builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1483608651.97 results: success (0) buildid: 20170104235539 builduid: 7acb914dcc3b458f836721abc0bdf45e revision: 75a0d7ccab1c43dc878ef1082117a30161f52d91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:51.969939) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:51.970375) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:51.970672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:52.069165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:52.069417) ========= 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=3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 01:30:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2017-01-05 01:30:52 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133183 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:52.355333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:52.355703) ========= 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=3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017293 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:52.430122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 01:30:52.430444) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 75a0d7ccab1c43dc878ef1082117a30161f52d91 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 75a0d7ccab1c43dc878ef1082117a30161f52d91 --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=3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 01:30:52,677 truncating revision to first 12 chars 2017-01-05 01:30:52,677 Setting DEBUG logging. 2017-01-05 01:30:52,677 attempt 1/10 2017-01-05 01:30:52,677 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/75a0d7ccab1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 01:30:52,998 unpacking tar archive at: mozilla-aurora-75a0d7ccab1c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629762 ========= master_lag: 0.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 01:30:53.744202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:53.747770) ========= script_repo_revision: 75a0d7ccab1c43dc878ef1082117a30161f52d91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:53.748331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:53.748645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 01:30:54.107436) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-05 01:30:54.110777) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:30:54 INFO - MultiFileLogger online at 20170105 01:30:54 in /builds/slave/test 01:30:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:30:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:30:54 INFO - {'append_to_log': False, 01:30:54 INFO - 'base_work_dir': '/builds/slave/test', 01:30:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:30:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:30:54 INFO - 'branch': 'Mozilla-Aurora', 01:30:54 INFO - 'buildbot_json_path': 'buildprops.json', 01:30:54 INFO - 'config_files': ('talos/linux_config.py',), 01:30:54 INFO - 'default_actions': ('clobber', 01:30:54 INFO - 'read-buildbot-config', 01:30:54 INFO - 'download-and-extract', 01:30:54 INFO - 'populate-webroot', 01:30:54 INFO - 'create-virtualenv', 01:30:54 INFO - 'install', 01:30:54 INFO - 'run-tests'), 01:30:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:30:54 INFO - 'download_minidump_stackwalk': True, 01:30:54 INFO - 'download_symbols': 'ondemand', 01:30:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:30:54 INFO - 'tooltool.py': '/tools/tooltool.py', 01:30:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:30:54 INFO - '/tools/misc-python/virtualenv.py')}, 01:30:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:30:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:30:54 INFO - 'installer_path': 'installer.exe', 01:30:54 INFO - 'log_level': 'info', 01:30:54 INFO - 'log_name': 'talos', 01:30:54 INFO - 'log_to_console': True, 01:30:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:30:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:30:54 INFO - 'opt_config_files': (), 01:30:54 INFO - 'pip_index': False, 01:30:54 INFO - 'sps_profile': False, 01:30:54 INFO - 'sps_profile_interval': 0, 01:30:54 INFO - 'suite': 'dromaeojs', 01:30:54 INFO - 'system_bits': '32', 01:30:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:30:54 INFO - 'title': 'talos-linux64-ix-030', 01:30:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:30:54 INFO - 'use_talos_json': True, 01:30:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:30:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:30:54 INFO - 'work_dir': 'build'} 01:30:54 INFO - [mozharness: 2017-01-05 09:30:54.448364Z] Running clobber step. 01:30:54 INFO - Running pre-action listener: _resource_record_pre_action 01:30:54 INFO - Running main action method: clobber 01:30:54 INFO - rmtree: /builds/slave/test/build 01:30:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:30:55 INFO - Running post-action listener: _resource_record_post_action 01:30:55 INFO - [mozharness: 2017-01-05 09:30:55.441216Z] Finished clobber step (success) 01:30:55 INFO - [mozharness: 2017-01-05 09:30:55.441316Z] Running read-buildbot-config step. 01:30:55 INFO - Running pre-action listener: _resource_record_pre_action 01:30:55 INFO - Running main action method: read_buildbot_config 01:30:55 INFO - Using buildbot properties: 01:30:55 INFO - { 01:30:55 INFO - "project": "", 01:30:55 INFO - "product": "firefox", 01:30:55 INFO - "script_repo_revision": "production", 01:30:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:30:55 INFO - "repository": "", 01:30:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:30:55 INFO - "buildid": "20170104235539", 01:30:55 INFO - "pgo_build": "True", 01:30:55 INFO - "basedir": "/builds/slave/test", 01:30:55 INFO - "buildnumber": 993, 01:30:55 INFO - "slavename": "talos-linux64-ix-030", 01:30:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:30:55 INFO - "platform": "ubuntu64_hw", 01:30:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:30:55 INFO - "branch": "mozilla-aurora", 01:30:55 INFO - "repo_path": "releases/mozilla-aurora", 01:30:55 INFO - "revision": "75a0d7ccab1c43dc878ef1082117a30161f52d91", 01:30:55 INFO - "stage_platform": "linux64-pgo", 01:30:55 INFO - "builduid": "7acb914dcc3b458f836721abc0bdf45e", 01:30:55 INFO - "slavebuilddir": "test" 01:30:55 INFO - } 01:30:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 01:30:55 INFO - Running post-action listener: _resource_record_post_action 01:30:55 INFO - [mozharness: 2017-01-05 09:30:55.443731Z] Finished read-buildbot-config step (success) 01:30:55 INFO - [mozharness: 2017-01-05 09:30:55.443819Z] Running download-and-extract step. 01:30:55 INFO - Running pre-action listener: _resource_record_pre_action 01:30:55 INFO - Running main action method: download_and_extract 01:30:55 INFO - mkdir: /builds/slave/test/build/tests 01:30: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')]} 01:30:55 INFO - trying https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 01:30:55 INFO - Downloading https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 01:30:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:30:56 INFO - Downloaded 1361 bytes. 01:30:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 01:30:56 INFO - Using the following test package requirements: 01:30:56 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 01:30:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:30:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:30:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:30:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:30:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:30:56 INFO - u'jsshell-linux-x86_64.zip'], 01:30:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:30:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:30:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 01:30:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:30:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:30:56 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:30:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:30:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:30:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:30:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:30:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:30:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:30:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 01:30:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:30:56 INFO - Fetch https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 01:30:56 INFO - Http code: 200 01:30:56 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 01:30:56 INFO - x-amz-cf-id: pCRHRJQJHZwltcqRJAOPgZtSFN0cXp4V9gJevQwU_atXYmCQJz79mA== 01:30:56 INFO - x-amz-version-id: DxV7o7jANgIA.x23RKMoKBmL0Gzkj5Nk 01:30:56 INFO - Expected file size: 21943062 01:30:56 INFO - Obtained file size: 21943062 01:31:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:31:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 01:31:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:31:00 INFO - Fetch https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 01:31:01 INFO - Http code: 200 01:31:01 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 01:31:01 INFO - x-amz-cf-id: QzXJTI4QKs9zta8reW3GYP0SI-nwUvcqHxlTGxqBQT9fttUGJ1TvWw== 01:31:01 INFO - x-amz-version-id: DxV7o7jANgIA.x23RKMoKBmL0Gzkj5Nk 01:31:01 INFO - Expected file size: 21943062 01:31:01 INFO - Obtained file size: 21943062 01:31:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 01:31:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:31:06 INFO - Fetch https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 01:31:06 INFO - Http code: 200 01:31:06 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 01:31:06 INFO - x-amz-cf-id: esmZhSqSwisix-Vj4qEpuSs7wSpPKIrSFRnUWb5mgKk-fEoqHdkxOg== 01:31:06 INFO - x-amz-version-id: B0AbSw2EHmOyZHQlN.0Op5O.CbJZOVP2 01:31:07 INFO - Expected file size: 14409038 01:31:07 INFO - Obtained file size: 14409038 01:31:07 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')]} 01:31:07 INFO - trying https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:31:07 INFO - Downloading https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:31:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:31:09 INFO - Downloaded 64055443 bytes. 01:31:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:31:09 INFO - mkdir: /builds/slave/test/properties 01:31:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:31:09 INFO - Writing to file /builds/slave/test/properties/build_url 01:31:09 INFO - Contents: 01:31:09 INFO - build_url:https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:31:09 INFO - Running post-action listener: _resource_record_post_action 01:31:09 INFO - Running post-action listener: set_extra_try_arguments 01:31:09 INFO - [mozharness: 2017-01-05 09:31:09.860721Z] Finished download-and-extract step (success) 01:31:09 INFO - [mozharness: 2017-01-05 09:31:09.860947Z] Running populate-webroot step. 01:31:09 INFO - Running pre-action listener: _resource_record_pre_action 01:31:09 INFO - Running main action method: populate_webroot 01:31:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:31:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:31:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:31:09 INFO - '--tppagecycles', 01:31:09 INFO - '7'], 01:31:09 INFO - 'tests': ['tsvgm']}}, 01:31:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:31:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:31:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:31:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:31:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:09 INFO - 'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:31:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:31:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:09 INFO - 'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['damp', 'tps']}, 01:31:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:09 INFO - 'tests': ['damp', 'tps']}, 01:31:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['dromaeo_dom']}, 01:31:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:31:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['basic_compositor_video']}, 01:31:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:31:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['a11yr', 01:31:09 INFO - 'ts_paint', 01:31:09 INFO - 'tpaint', 01:31:09 INFO - 'sessionrestore', 01:31:09 INFO - 'sessionrestore_no_auto_restore', 01:31:09 INFO - 'tabpaint']}, 01:31:09 INFO - 'other-e10s': {'tests': ['a11yr', 01:31:09 INFO - 'ts_paint', 01:31:09 INFO - 'tpaint', 01:31:09 INFO - 'sessionrestore', 01:31:09 INFO - 'sessionrestore_no_auto_restore', 01:31:09 INFO - 'tabpaint']}, 01:31:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:31:09 INFO - 'ts_paint', 01:31:09 INFO - 'tpaint', 01:31:09 INFO - 'sessionrestore', 01:31:09 INFO - 'sessionrestore_no_auto_restore', 01:31:09 INFO - 'tabpaint']}, 01:31:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:31:09 INFO - 'ts_paint', 01:31:09 INFO - 'tpaint', 01:31:09 INFO - 'sessionrestore', 01:31:09 INFO - 'sessionrestore_no_auto_restore', 01:31:09 INFO - 'tabpaint']}, 01:31:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['a11yr', 01:31:09 INFO - 'ts_paint', 01:31:09 INFO - 'tpaint', 01:31:09 INFO - 'sessionrestore', 01:31:09 INFO - 'sessionrestore_no_auto_restore', 01:31:09 INFO - 'tabpaint']}, 01:31:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['a11yr', 01:31:09 INFO - 'ts_paint', 01:31:09 INFO - 'tpaint', 01:31:09 INFO - 'sessionrestore', 01:31:09 INFO - 'sessionrestore_no_auto_restore', 01:31:09 INFO - 'tabpaint']}, 01:31:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['tsvgx', 01:31:09 INFO - 'tsvgr_opacity', 01:31:09 INFO - 'tart', 01:31:09 INFO - 'tscrollx', 01:31:09 INFO - 'cart']}, 01:31:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:31:09 INFO - 'tsvgr_opacity', 01:31:09 INFO - 'tart', 01:31:09 INFO - 'tscrollx', 01:31:09 INFO - 'cart']}, 01:31:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:09 INFO - 'talos_options': ['--disable-e10s'], 01:31:09 INFO - 'tests': ['tp5o']}, 01:31:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:09 INFO - 'tests': ['tp5o']}, 01:31:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:09 INFO - 'talos_options': ['--disable-e10s', 01:31:09 INFO - '--xperf_path', 01:31:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:31:09 INFO - 'tests': ['tp5n']}, 01:31:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:09 INFO - 'talos_options': ['--xperf_path', 01:31:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:31:09 INFO - 'tests': ['tp5n']}}, 01:31:09 INFO - 'talos.zip': {'path': '', 01:31:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:31:09 INFO - Running post-action listener: _resource_record_post_action 01:31:09 INFO - [mozharness: 2017-01-05 09:31:09.876335Z] Finished populate-webroot step (success) 01:31:09 INFO - [mozharness: 2017-01-05 09:31:09.876424Z] Running create-virtualenv step. 01:31:09 INFO - Running pre-action listener: _resource_record_pre_action 01:31:09 INFO - Running main action method: create_virtualenv 01:31:09 INFO - Creating virtualenv /builds/slave/test/build/venv 01:31:09 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 01:31:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:31:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:31:09 INFO - Using real prefix '/usr' 01:31:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:31:10 INFO - Installing distribute.............................................................................................................................................................................................done. 01:31:12 INFO - Installing pip.................done. 01:31:12 INFO - Return code: 0 01:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:31:12 INFO - Reading from file tmpfile_stdout 01:31:12 INFO - Output received: 01:31:12 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) 01:31:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:31:12 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')]} 01:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:12 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')]} 01:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:12 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 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:12 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 01:31:12 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 01:31:12 INFO - Using env: {'DISPLAY': ':0', 01:31:12 INFO - 'HOME': '/home/cltbld', 01:31:12 INFO - 'LANG': 'en_US.UTF-8', 01:31:12 INFO - 'LANGUAGE': 'en_US:en', 01:31:12 INFO - 'LOGNAME': 'cltbld', 01:31:12 INFO - 'MAIL': '/var/mail/cltbld', 01:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:12 INFO - 'MOZ_NO_REMOTE': '1', 01:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:12 INFO - 'NO_EM_RESTART': '1', 01:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:12 INFO - 'PWD': '/builds/slave/test', 01:31:12 INFO - 'SHELL': '/bin/bash', 01:31:12 INFO - 'SHLVL': '1', 01:31:12 INFO - 'TERM': 'linux', 01:31:12 INFO - 'TMOUT': '86400', 01:31:12 INFO - 'USER': 'cltbld', 01:31:12 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:12 INFO - '_': '/tools/buildbot/bin/python'} 01:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:12 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 01:31:12 INFO - Cleaning up... 01:31:12 INFO - Return code: 0 01:31:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:31:12 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')]} 01:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:12 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')]} 01:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:12 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 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:12 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 01:31:12 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 01:31:12 INFO - Using env: {'DISPLAY': ':0', 01:31:12 INFO - 'HOME': '/home/cltbld', 01:31:12 INFO - 'LANG': 'en_US.UTF-8', 01:31:12 INFO - 'LANGUAGE': 'en_US:en', 01:31:12 INFO - 'LOGNAME': 'cltbld', 01:31:12 INFO - 'MAIL': '/var/mail/cltbld', 01:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:12 INFO - 'MOZ_NO_REMOTE': '1', 01:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:12 INFO - 'NO_EM_RESTART': '1', 01:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:12 INFO - 'PWD': '/builds/slave/test', 01:31:12 INFO - 'SHELL': '/bin/bash', 01:31:12 INFO - 'SHLVL': '1', 01:31:12 INFO - 'TERM': 'linux', 01:31:12 INFO - 'TMOUT': '86400', 01:31:12 INFO - 'USER': 'cltbld', 01:31:12 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:12 INFO - '_': '/tools/buildbot/bin/python'} 01:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:13 INFO - Downloading/unpacking psutil>=3.1.1 01:31:13 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 01:31:13 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 01:31:13 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 01:31:13 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 01:31:13 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 01:31:13 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 01:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:31:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:31:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:31:15 INFO - Installing collected packages: psutil 01:31:15 INFO - Running setup.py install for psutil 01:31:15 INFO - building 'psutil._psutil_linux' extension 01:31:15 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 01:31:15 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 01:31:15 INFO - building 'psutil._psutil_posix' extension 01:31:15 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 01:31:15 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 01:31:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:31:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:31:15 INFO - Successfully installed psutil 01:31:15 INFO - Cleaning up... 01:31:15 INFO - Return code: 0 01:31:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:31:15 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')]} 01:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:15 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')]} 01:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:31:15 INFO - Using env: {'DISPLAY': ':0', 01:31:15 INFO - 'HOME': '/home/cltbld', 01:31:15 INFO - 'LANG': 'en_US.UTF-8', 01:31:15 INFO - 'LANGUAGE': 'en_US:en', 01:31:15 INFO - 'LOGNAME': 'cltbld', 01:31:15 INFO - 'MAIL': '/var/mail/cltbld', 01:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:15 INFO - 'MOZ_NO_REMOTE': '1', 01:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:15 INFO - 'NO_EM_RESTART': '1', 01:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:15 INFO - 'PWD': '/builds/slave/test', 01:31:15 INFO - 'SHELL': '/bin/bash', 01:31:15 INFO - 'SHLVL': '1', 01:31:15 INFO - 'TERM': 'linux', 01:31:15 INFO - 'TMOUT': '86400', 01:31:15 INFO - 'USER': 'cltbld', 01:31:15 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:15 INFO - '_': '/tools/buildbot/bin/python'} 01:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:31:18 INFO - Installing collected packages: mozsystemmonitor 01:31:18 INFO - Running setup.py install for mozsystemmonitor 01:31:18 INFO - Successfully installed mozsystemmonitor 01:31:18 INFO - Cleaning up... 01:31:18 INFO - Return code: 0 01:31:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:31:18 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')]} 01:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:18 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')]} 01:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:18 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 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:18 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 01:31:18 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 01:31:18 INFO - Using env: {'DISPLAY': ':0', 01:31:18 INFO - 'HOME': '/home/cltbld', 01:31:18 INFO - 'LANG': 'en_US.UTF-8', 01:31:18 INFO - 'LANGUAGE': 'en_US:en', 01:31:18 INFO - 'LOGNAME': 'cltbld', 01:31:18 INFO - 'MAIL': '/var/mail/cltbld', 01:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:18 INFO - 'MOZ_NO_REMOTE': '1', 01:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:18 INFO - 'NO_EM_RESTART': '1', 01:31:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:18 INFO - 'PWD': '/builds/slave/test', 01:31:18 INFO - 'SHELL': '/bin/bash', 01:31:18 INFO - 'SHLVL': '1', 01:31:18 INFO - 'TERM': 'linux', 01:31:18 INFO - 'TMOUT': '86400', 01:31:18 INFO - 'USER': 'cltbld', 01:31:18 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:18 INFO - '_': '/tools/buildbot/bin/python'} 01:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:18 INFO - Downloading/unpacking jsonschema==2.5.1 01:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:31:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:20 INFO - Downloading functools32-3.2.3-2.tar.gz 01:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:31:20 INFO - warning: no files found matching '*.txt' 01:31:20 INFO - no previously-included directories found matching 'build' 01:31:20 INFO - no previously-included directories found matching 'dist' 01:31:20 INFO - no previously-included directories found matching '.git*' 01:31:20 INFO - Installing collected packages: jsonschema, functools32 01:31:20 INFO - Running setup.py install for functools32 01:31:20 INFO - warning: no files found matching '*.txt' 01:31:20 INFO - no previously-included directories found matching 'build' 01:31:20 INFO - no previously-included directories found matching 'dist' 01:31:20 INFO - no previously-included directories found matching '.git*' 01:31:20 INFO - Successfully installed jsonschema functools32 01:31:20 INFO - Cleaning up... 01:31:20 INFO - Return code: 0 01:31:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:31:20 INFO - Using env: {'DISPLAY': ':0', 01:31:20 INFO - 'HOME': '/home/cltbld', 01:31:20 INFO - 'LANG': 'en_US.UTF-8', 01:31:20 INFO - 'LANGUAGE': 'en_US:en', 01:31:20 INFO - 'LOGNAME': 'cltbld', 01:31:20 INFO - 'MAIL': '/var/mail/cltbld', 01:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:20 INFO - 'MOZ_NO_REMOTE': '1', 01:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:20 INFO - 'NO_EM_RESTART': '1', 01:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:20 INFO - 'PWD': '/builds/slave/test', 01:31:20 INFO - 'SHELL': '/bin/bash', 01:31:20 INFO - 'SHLVL': '1', 01:31:20 INFO - 'TERM': 'linux', 01:31:20 INFO - 'TMOUT': '86400', 01:31:20 INFO - 'USER': 'cltbld', 01:31:20 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:20 INFO - '_': '/tools/buildbot/bin/python'} 01:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:31:21 INFO - Cleaning up... 01:31:21 INFO - Return code: 0 01:31:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:31:21 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')]} 01:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:21 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')]} 01:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:21 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 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:21 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 01:31:21 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 01:31:21 INFO - Using env: {'DISPLAY': ':0', 01:31:21 INFO - 'HOME': '/home/cltbld', 01:31:21 INFO - 'LANG': 'en_US.UTF-8', 01:31:21 INFO - 'LANGUAGE': 'en_US:en', 01:31:21 INFO - 'LOGNAME': 'cltbld', 01:31:21 INFO - 'MAIL': '/var/mail/cltbld', 01:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:21 INFO - 'MOZ_NO_REMOTE': '1', 01:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:21 INFO - 'NO_EM_RESTART': '1', 01:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:21 INFO - 'PWD': '/builds/slave/test', 01:31:21 INFO - 'SHELL': '/bin/bash', 01:31:21 INFO - 'SHLVL': '1', 01:31:21 INFO - 'TERM': 'linux', 01:31:21 INFO - 'TMOUT': '86400', 01:31:21 INFO - 'USER': 'cltbld', 01:31:21 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:21 INFO - '_': '/tools/buildbot/bin/python'} 01:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:21 INFO - Downloading/unpacking blobuploader==1.2.4 01:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:23 INFO - Downloading blobuploader-1.2.4.tar.gz 01:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:31:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:31:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:31:24 INFO - Downloading docopt-0.6.1.tar.gz 01:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:31:24 INFO - Installing collected packages: blobuploader, requests, docopt 01:31:24 INFO - Running setup.py install for blobuploader 01:31:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:31:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:31:24 INFO - Running setup.py install for requests 01:31:24 INFO - Running setup.py install for docopt 01:31:24 INFO - Successfully installed blobuploader requests docopt 01:31:24 INFO - Cleaning up... 01:31:24 INFO - Return code: 0 01:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:24 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 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:24 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 01:31:24 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 01:31:24 INFO - Using env: {'DISPLAY': ':0', 01:31:24 INFO - 'HOME': '/home/cltbld', 01:31:24 INFO - 'LANG': 'en_US.UTF-8', 01:31:24 INFO - 'LANGUAGE': 'en_US:en', 01:31:24 INFO - 'LOGNAME': 'cltbld', 01:31:24 INFO - 'MAIL': '/var/mail/cltbld', 01:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:24 INFO - 'MOZ_NO_REMOTE': '1', 01:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:24 INFO - 'NO_EM_RESTART': '1', 01:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:24 INFO - 'PWD': '/builds/slave/test', 01:31:24 INFO - 'SHELL': '/bin/bash', 01:31:24 INFO - 'SHLVL': '1', 01:31:24 INFO - 'TERM': 'linux', 01:31:24 INFO - 'TMOUT': '86400', 01:31:24 INFO - 'USER': 'cltbld', 01:31:24 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:24 INFO - '_': '/tools/buildbot/bin/python'} 01:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:31:24 INFO - Running setup.py (path:/tmp/pip-6jd65d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:31:25 INFO - Running setup.py (path:/tmp/pip-QPPdrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:31:25 INFO - Running setup.py (path:/tmp/pip-jBMS39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:31:25 INFO - Running setup.py (path:/tmp/pip-HhE0Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:31:25 INFO - Running setup.py (path:/tmp/pip-tJvoVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:31:25 INFO - Running setup.py (path:/tmp/pip-yWWDTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:31:25 INFO - Running setup.py (path:/tmp/pip-xiLnoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:31:25 INFO - Running setup.py (path:/tmp/pip-_aWZQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:31:25 INFO - Running setup.py (path:/tmp/pip-SYo8Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:31:25 INFO - Running setup.py (path:/tmp/pip-nT0MKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:31:25 INFO - Running setup.py (path:/tmp/pip-8XslJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:31:25 INFO - Running setup.py (path:/tmp/pip-7DOSRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:31:25 INFO - Running setup.py (path:/tmp/pip-6uR_ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:31:25 INFO - Running setup.py (path:/tmp/pip-INt4lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:31:25 INFO - Running setup.py (path:/tmp/pip-0SwGp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:31:26 INFO - Running setup.py (path:/tmp/pip-GHzdL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:31:26 INFO - Running setup.py (path:/tmp/pip-bkHXwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:31:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:31:26 INFO - Running setup.py install for manifestparser 01:31:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:31:26 INFO - Running setup.py install for mozcrash 01:31:26 INFO - Running setup.py install for mozdebug 01:31:26 INFO - Running setup.py install for mozdevice 01:31:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:31:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:31:26 INFO - Running setup.py install for mozfile 01:31:26 INFO - Running setup.py install for mozhttpd 01:31:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:31:26 INFO - Running setup.py install for mozinfo 01:31:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:31:26 INFO - Running setup.py install for mozInstall 01:31:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:31:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:31:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:31:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:31:26 INFO - Running setup.py install for mozleak 01:31:27 INFO - Running setup.py install for mozlog 01:31:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:31:27 INFO - Running setup.py install for moznetwork 01:31:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:31:27 INFO - Running setup.py install for mozprocess 01:31:27 INFO - Running setup.py install for mozprofile 01:31:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:31:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:31:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:31:27 INFO - Running setup.py install for mozrunner 01:31:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:31:27 INFO - Running setup.py install for mozscreenshot 01:31:27 INFO - Running setup.py install for moztest 01:31:27 INFO - Running setup.py install for mozversion 01:31:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:31:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:31:27 INFO - Cleaning up... 01:31:27 INFO - Return code: 0 01:31:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:27 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 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:27 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 01:31:27 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 01:31:27 INFO - Using env: {'DISPLAY': ':0', 01:31:27 INFO - 'HOME': '/home/cltbld', 01:31:27 INFO - 'LANG': 'en_US.UTF-8', 01:31:27 INFO - 'LANGUAGE': 'en_US:en', 01:31:27 INFO - 'LOGNAME': 'cltbld', 01:31:27 INFO - 'MAIL': '/var/mail/cltbld', 01:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:27 INFO - 'MOZ_NO_REMOTE': '1', 01:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:27 INFO - 'NO_EM_RESTART': '1', 01:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:27 INFO - 'PWD': '/builds/slave/test', 01:31:27 INFO - 'SHELL': '/bin/bash', 01:31:27 INFO - 'SHLVL': '1', 01:31:27 INFO - 'TERM': 'linux', 01:31:27 INFO - 'TMOUT': '86400', 01:31:27 INFO - 'USER': 'cltbld', 01:31:27 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:27 INFO - '_': '/tools/buildbot/bin/python'} 01:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:31:28 INFO - Running setup.py (path:/tmp/pip-mxpTPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:31:28 INFO - Running setup.py (path:/tmp/pip-SvmYrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:31:28 INFO - Running setup.py (path:/tmp/pip-LPnN0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:31:28 INFO - Running setup.py (path:/tmp/pip-kRNWRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:31:28 INFO - Running setup.py (path:/tmp/pip-nqvmaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:31:28 INFO - Running setup.py (path:/tmp/pip-HNFD1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:31:28 INFO - Running setup.py (path:/tmp/pip-74qC_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:31:28 INFO - Running setup.py (path:/tmp/pip-T0QUnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:31:28 INFO - Running setup.py (path:/tmp/pip-ZdEx2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:31:28 INFO - Running setup.py (path:/tmp/pip-oV0U5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:31:28 INFO - Running setup.py (path:/tmp/pip-YUZYOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:31:28 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)) 01:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:31:28 INFO - Running setup.py (path:/tmp/pip-z6veo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:31:29 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)) 01:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:31:29 INFO - Running setup.py (path:/tmp/pip-qat7Wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:31:29 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)) 01:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:31:29 INFO - Running setup.py (path:/tmp/pip-F9bq6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:31:29 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)) 01:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:31:29 INFO - Running setup.py (path:/tmp/pip-QwQWqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:31:29 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)) 01:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:31:29 INFO - Running setup.py (path:/tmp/pip-LdZCV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:31:29 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)) 01:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:31:29 INFO - Running setup.py (path:/tmp/pip-h23SO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:31:29 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)) 01:31:29 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)) 01:31:29 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)) 01:31:29 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)) 01:31:29 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)) 01:31:29 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)) 01:31:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:31:29 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 01:31:29 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 01:31:29 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 01:31:29 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 01:31:29 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 01:31:29 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 01:31:32 INFO - Downloading blessings-1.6.tar.gz 01:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:31:32 INFO - Installing collected packages: blessings 01:31:32 INFO - Running setup.py install for blessings 01:31:32 INFO - Successfully installed blessings 01:31:32 INFO - Cleaning up... 01:31:32 INFO - Return code: 0 01:31:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:31:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:31:32 INFO - Reading from file tmpfile_stdout 01:31:32 INFO - Current package versions: 01:31:32 INFO - argparse == 1.2.1 01:31:32 INFO - blessings == 1.6 01:31:32 INFO - blobuploader == 1.2.4 01:31:32 INFO - docopt == 0.6.1 01:31:32 INFO - functools32 == 3.2.3-2 01:31:32 INFO - jsonschema == 2.5.1 01:31:32 INFO - manifestparser == 1.1 01:31:32 INFO - mozInstall == 1.12 01:31:32 INFO - mozcrash == 1.0 01:31:32 INFO - mozdebug == 0.1 01:31:32 INFO - mozdevice == 0.48 01:31:32 INFO - mozfile == 1.2 01:31:32 INFO - mozhttpd == 0.7 01:31:32 INFO - mozinfo == 0.9 01:31:32 INFO - mozleak == 0.1 01:31:32 INFO - mozlog == 3.4 01:31:32 INFO - moznetwork == 0.27 01:31:32 INFO - mozprocess == 0.23 01:31:32 INFO - mozprofile == 0.28 01:31:32 INFO - mozrunner == 6.13 01:31:32 INFO - mozscreenshot == 0.1 01:31:32 INFO - mozsystemmonitor == 0.3 01:31:32 INFO - moztest == 0.8 01:31:32 INFO - mozversion == 1.4 01:31:32 INFO - psutil == 3.1.1 01:31:32 INFO - requests == 1.2.3 01:31:32 INFO - wsgiref == 0.1.2 01:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:32 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 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:32 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 01:31:32 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 01:31:32 INFO - Using env: {'DISPLAY': ':0', 01:31:32 INFO - 'HOME': '/home/cltbld', 01:31:32 INFO - 'LANG': 'en_US.UTF-8', 01:31:32 INFO - 'LANGUAGE': 'en_US:en', 01:31:32 INFO - 'LOGNAME': 'cltbld', 01:31:32 INFO - 'MAIL': '/var/mail/cltbld', 01:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:32 INFO - 'MOZ_NO_REMOTE': '1', 01:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:32 INFO - 'NO_EM_RESTART': '1', 01:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:32 INFO - 'PWD': '/builds/slave/test', 01:31:32 INFO - 'SHELL': '/bin/bash', 01:31:32 INFO - 'SHLVL': '1', 01:31:32 INFO - 'TERM': 'linux', 01:31:32 INFO - 'TMOUT': '86400', 01:31:32 INFO - 'USER': 'cltbld', 01:31:32 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:32 INFO - '_': '/tools/buildbot/bin/python'} 01:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:33 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)) 01:31:33 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)) 01:31:33 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)) 01:31:33 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)) 01:31:33 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)) 01:31:33 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)) 01:31:33 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)) 01:31:33 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)) 01:31:33 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)) 01:31:33 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)) 01:31:33 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)) 01:31:33 INFO - Cleaning up... 01:31:33 INFO - Return code: 0 01:31:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:31: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')]} 01:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31: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')]} 01:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:33 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 0x7fc9d1697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', '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 01:31:33 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 01:31:33 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 01:31:33 INFO - Using env: {'DISPLAY': ':0', 01:31:33 INFO - 'HOME': '/home/cltbld', 01:31:33 INFO - 'LANG': 'en_US.UTF-8', 01:31:33 INFO - 'LANGUAGE': 'en_US:en', 01:31:33 INFO - 'LOGNAME': 'cltbld', 01:31:33 INFO - 'MAIL': '/var/mail/cltbld', 01:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:33 INFO - 'MOZ_NO_REMOTE': '1', 01:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:33 INFO - 'NO_EM_RESTART': '1', 01:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:33 INFO - 'PWD': '/builds/slave/test', 01:31:33 INFO - 'SHELL': '/bin/bash', 01:31:33 INFO - 'SHLVL': '1', 01:31:33 INFO - 'TERM': 'linux', 01:31:33 INFO - 'TMOUT': '86400', 01:31:33 INFO - 'USER': 'cltbld', 01:31:33 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:33 INFO - '_': '/tools/buildbot/bin/python'} 01:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:31:33 INFO - Cleaning up... 01:31:33 INFO - Return code: 0 01:31:33 INFO - Running post-action listener: _resource_record_post_action 01:31:33 INFO - Running post-action listener: _start_resource_monitoring 01:31:33 INFO - Starting resource monitoring. 01:31:33 INFO - [mozharness: 2017-01-05 09:31:33.371241Z] Finished create-virtualenv step (success) 01:31:33 INFO - [mozharness: 2017-01-05 09:31:33.371736Z] Running install step. 01:31:33 INFO - Running pre-action listener: _resource_record_pre_action 01:31:33 INFO - Running main action method: install 01:31:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:31:33 INFO - Reading from file tmpfile_stdout 01:31:33 INFO - Detecting whether we're running mozinstall >=1.0... 01:31:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:31:33 INFO - Reading from file tmpfile_stdout 01:31:33 INFO - Output received: 01:31:33 INFO - Usage: mozinstall [options] installer 01:31:33 INFO - Options: 01:31:33 INFO - -h, --help show this help message and exit 01:31:33 INFO - -d DEST, --destination=DEST 01:31:33 INFO - Directory to install application into. [default: 01:31:33 INFO - "/builds/slave/test"] 01:31:33 INFO - --app=APP Application being installed. [default: firefox] 01:31:33 INFO - mkdir: /builds/slave/test/build/application 01:31:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:31:49 INFO - Reading from file tmpfile_stdout 01:31:49 INFO - Output received: 01:31:49 INFO - /builds/slave/test/build/application/firefox/firefox 01:31:49 INFO - Running post-action listener: _resource_record_post_action 01:31:49 INFO - [mozharness: 2017-01-05 09:31:49.612015Z] Finished install step (success) 01:31:49 INFO - [mozharness: 2017-01-05 09:31:49.612257Z] Running run-tests step. 01:31:49 INFO - Running pre-action listener: _resource_record_pre_action 01:31:49 INFO - Running main action method: run_tests 01:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:31:49 INFO - Python 2.7.3 01:31:49 INFO - Return code: 0 01:31:49 INFO - grabbing minidump binary from tooltool 01:31: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')]} 01:31:49 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 0x1c38f60>, '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 0x1c39d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c3a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:31:49 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 01:31:49 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 01:31:49 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 01:31:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:31:49 INFO - Return code: 0 01:31:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:31:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:31:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:31:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:31:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 01:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 01:31:49 INFO - Using env: {'DISPLAY': ':0', 01:31:49 INFO - 'HOME': '/home/cltbld', 01:31:49 INFO - 'LANG': 'en_US.UTF-8', 01:31:49 INFO - 'LANGUAGE': 'en_US:en', 01:31:49 INFO - 'LOGNAME': 'cltbld', 01:31:49 INFO - 'MAIL': '/var/mail/cltbld', 01:31:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:31:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:49 INFO - 'MOZ_NO_REMOTE': '1', 01:31:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:49 INFO - 'NO_EM_RESTART': '1', 01:31:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:49 INFO - 'PWD': '/builds/slave/test', 01:31:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:31:49 INFO - 'SHELL': '/bin/bash', 01:31:49 INFO - 'SHLVL': '1', 01:31:49 INFO - 'TERM': 'linux', 01:31:49 INFO - 'TMOUT': '86400', 01:31:49 INFO - 'USER': 'cltbld', 01:31:49 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940', 01:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:49 INFO - '_': '/tools/buildbot/bin/python'} 01:31:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 01:31:49 INFO - mozversion application_buildid: 20170104235539 01:31:49 INFO - mozversion application_changeset: 75a0d7ccab1c43dc878ef1082117a30161f52d91 01:31:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:31:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:31:49 INFO - mozversion application_name: Firefox 01:31:49 INFO - mozversion application_remotingname: firefox-dev 01:31:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:31:49 INFO - mozversion application_vendor: Mozilla 01:31:49 INFO - mozversion application_version: 52.0a2 01:31:49 INFO - mozversion platform_buildid: 20170104235539 01:31:49 INFO - mozversion platform_changeset: 75a0d7ccab1c43dc878ef1082117a30161f52d91 01:31:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:31:49 INFO - mozversion platform_version: 52.0a2 01:31:49 INFO - using testdate: 1483608709 01:31:49 INFO - actual date: 1483608709 01:31:49 INFO - starting webserver on 'localhost:34030' 01:31:49 INFO - SUITE-START | Running 2 tests 01:31:49 INFO - TEST-START | dromaeo_css 01:31:49 INFO - operating with platform_type : linux_ 01:31:49 INFO - Initialising browser for dromaeo_css test... 01:31:49 INFO - TEST-INFO | started process 9602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWQ4BZt/profile http://localhost:34030/getInfo.html) 01:31:54 INFO - PROCESS | 9602 | __metrics Screen width/height:1600/1200 01:31:54 INFO - PROCESS | 9602 | colorDepth:24 01:31:54 INFO - PROCESS | 9602 | Browser inner width/height: 1024/697 01:31:54 INFO - PROCESS | 9602 | __metrics 01:31:54 INFO - PROCESS | 9602 | 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" 01:31:54 INFO - PROCESS | 9602 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:31:55 INFO - PROCESS | 9602 | console.error: PushService: 01:31:55 INFO - PROCESS | 9602 | stateChangeProcessEnqueue: Error transitioning state 01:31:55 INFO - PROCESS | 9602 | UnknownError 01:31:55 INFO - TEST-INFO | 9602: exit 0 01:31:55 INFO - Browser initialized. 01:31:55 INFO - Running cycle 1/1 for dromaeo_css test... 01:31:55 INFO - TEST-INFO | started process 9695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWQ4BZt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:32:07 INFO - PROCESS | 9695 | RSS: Main: 144588800 01:32:07 INFO - PROCESS | 9695 | 01:35:09 INFO - PROCESS | 9695 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34030/tests/dromaeo/cssquery-ext.html) 01:35:10 INFO - PROCESS | 9695 | RSS: Main: 248254464 01:35:10 INFO - PROCESS | 9695 | 01:38:13 INFO - PROCESS | 9695 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-ext.html (next: http://localhost:34030/tests/dromaeo/cssquery-jquery.html) 01:38:13 INFO - PROCESS | 9695 | RSS: Main: 219058176 01:38:13 INFO - PROCESS | 9695 | 01:41:15 INFO - PROCESS | 9695 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34030/tests/dromaeo/cssquery-mootools.html) 01:41:16 INFO - PROCESS | 9695 | RSS: Main: 176328704 01:41:16 INFO - PROCESS | 9695 | 01:44:18 INFO - PROCESS | 9695 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34030/tests/dromaeo/cssquery-prototype.html) 01:44:18 INFO - PROCESS | 9695 | RSS: Main: 227520512 01:44:18 INFO - PROCESS | 9695 | 01:47:21 INFO - PROCESS | 9695 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34030/tests/dromaeo/cssquery-yui.html) 01:47:22 INFO - PROCESS | 9695 | RSS: Main: 175386624 01:47:22 INFO - PROCESS | 9695 | 01:50:24 INFO - PROCESS | 9695 | Cycle 1(1): loaded http://localhost:34030/tests/dromaeo/cssquery-yui.html (next: http://localhost:34030/tests/dromaeo/cssquery-dojo.html) 01:50:24 INFO - PROCESS | 9695 | RSS: Main: 265269248 01:50:24 INFO - PROCESS | 9695 | 01:50:24 INFO - PROCESS | 9695 | __start_tp_report 01:50:24 INFO - PROCESS | 9695 | _x_x_mozilla_page_load 01:50:24 INFO - PROCESS | 9695 | _x_x_mozilla_page_load_details 01:50:24 INFO - PROCESS | 9695 | |i|pagename|runs| 01:50:24 INFO - PROCESS | 9695 | |0;dojo.html;3244.497102949043;3291.6050073991123;3296.604407471103;3298.884539041134;3322.717569006634;5603.467670571295;5649.406812284702;5681.204631351614;5686.658800471974;5697.886042279157;5595.916061259084;5649.689267090308;5652.0391533439315;5654.208410822488;5677.545796336293;5073.873153171173;5101.438841727407;5109.591232701375;5129.461406552315;5158.432572417031;5069.949300506984;5072.543471087602;5101.897962040757;5196.116660167761;5210.921836172461;5171.922421163686;5234.110201265794;5241.868953276179;5255.421903590602;5270.314859068316;5254.211868219798;5261.079311120558;5264.42091369949;5270.789168433277;5304;4943.258511223309;5040.42035165957;5146;5156.097682905514;5218.034663587248;5466.043442397565;5515.862103447405;5547.694876781776;5559.19391688207;5566.387697353288;6052.485538729214;6078.6048906820915;6083.726232319512;6088.208532890741;6091.969540152315;5839.532837373043;6126.754929802847;6135.478484328793;6154.384561543855;6157.907631385533;5515.503604675559;5602.915956260659;5670.404607516234;5673.347565030074;5704.315482142087;6225.128482012522;6248.50011999039;6251.687415629201;6256.249250090018;6260.217472815898;5737.454941780524;5992.221011268507;5993.400659933972;6000.459958603659;6005.6396616203165;5796.246487956539;5952.494038006731;5989.970050149808;5993.460588547052;6114.38856114385;6018.21763170785;6022.45797878193;6030.396960304022;6037.72830222641;6088.238970128734;5825.825225243249;6071.301800293023;6072.089186622042;6072.817815465543;6080.69596520181;4561.429821272341;4598.425196850394;4611.677182597186;4630.050839577879;4634.791434385461;4127.442795222607;4136.772477513766;4147.149834283965;4169.1661667666585;4175.561566035583;5734.856628584319;5770.6249093808765;5774.711264436762;5789.131630255495;5803.622764520293;5847.912281315784;5897.64614123154;6008.09878518217;6069.241344831896;6128.080787881764;5812.534997200214;5814.622049566765;5815.41845815415;5822.417758224144;5843.5325173985975;5247.02929957959;5294.629375943647;5296.443873393316;5298.258243845788;5299.364076310867;6084.69576521181;6116.396640261158;6174.876502469836;6379.968100159563;6393;5989.191459153133;6070.271567411939;6076.331603523698;6094.878102438015;6098.390160983866;6281.277653069773;6298.685065746786;6299.622022678654;6302.5588208826775;6310.11658367838;5755.021646320052;5803;5911.142884281841;5958.493528049991;5970.996876510074;6008.369121242206;6034.909476357946;6061.1514387984835;6120.143179954899;6137.7851775187655;5898.203742494708;5940.940590594211;5952.494038006818;5953.464188223081;5959.344472108151;5688.715564221855;5939.46544810969;5942.851428714317;5943.613665111754;5961;5751.539876809761;5796.59423840344;5837.737301821513;5853.619514731528;5924.229850119457;5953.10703394477;5959.463648271676;5962.970185149046;5969.850753731192;5978.671173085522;5640.323161220515;5693.259876216231;5700.572457065819;5791.739371728198;5835.766569337179 01:50:24 INFO - PROCESS | 9695 | |1;ext.html;589.4488653109343;606.8045949479526;637.3021541412154;656.6749459017786;672.5258692621702;33339.833300833496;36274.27451450969;36331.45502817457;36368.45447318286;36519.26961460769;36599.4510082349;45181;45832.3125153123;45980.310295345516;49940;8698.173673501024;8826.338024648145;8830.11698830115;8836.734897953073;8837.690680826172;8437.746867593982;8661.870071948895;8700.086490918457;8783;8789.560521973908;8640.265577425926;10478.685639430829;10722.731931701692;10741.140708743322;11120.443977801118;10764.031237188652;10833.241673082888;10848.945755271252;10849.349039057683;10849.83725244118;10634.840477392845;10707.625233116803;10707.946460267727;10713.892861071368;10714.142868570496;44696;44855.775721121514;44913.326300105524;44942.77528612369;45025.32462013073;3489.6335884732243;3556.5020897074432;3779.1874746929543;3916.8824935251705;4370.169667763115;31675;31702.36595268082;31713.524297135562;32081.679183208103;32418.6758132418;4429.158459892642;4533.909321813579;4559.726416415026;4608.700434471749;4684.36761037259;350307;359727;364668;365212;366853;62939.370606294266;63297.36702632915;63299;63311;63318.68340658267;40063;40679.38980915289;40688.186236275105;43481.782591087474;67439.32560674331;18656.813431865507;18823.247070117042;18854.245830166914;18873.81126188748;18875.90562047181;14487.78268325976;14551.708965820624;14587.124772513684;14593.270336483134;14595.343209555384;18348.357807476674;18757.90621046886;19638.21447142127;20833.58332833335;20981.68527472089;7321.74373896911;7491.288327608869;7614.847703046019;7694.615269236516;7821.100573434014;997.3168379659957;1085.2945585369416;1088.684281558355;1132.9433528323716;1140.5152810055692;33406.49890251648;33639.83180084084;33815.661843381255;34003.65996340055;34448.82775586106;1002.4536627538009;1119.658504156224;1163.1799581295168;1167.5913430299327;1189.726362936512;16459.423920162975;17737.290508379778;17755.556111097325;18493;18520.444386668423;538035;546326;548377;549850;549932;61347.69326153341;62092;62165.68917155385;62316.68841655763;62360.37639623637;1298.1172802494207;1348.9460421583224;1361.5438827992734;1412.9364178611986;1436.2818590704649;30486.695133048386;34752.304953901286;35347;37100.81449592735;37179;57264.42735572591;58557.12164317624;58627.41372586219;58739.70630146822;58771.41228587659;355757;358021;358682;359912;360910;29653.406931861675;30571.694283056884;31458.842705786323;31594.842025789723;31868.362632747678;38033.80983095067;50466.2430063542;51012.48987510077;55458.44541554694;55730.16404754013;40172.3974140394;41283.38074928938;42024.789876050425;42507.7874610625;43590.34614480722;40227;41698.37452438155;41866;41923.1615367697;44739.77630111828;43689.56310436855;44028.33957490576;44237.77881110574;44254;44880.32679509745;36526;38954.04672455358;39077.06534222312;39141.80429097836;39351;29240.528371352353;29511.11466656004;29556.556651650673;29951.850240748656;29981.400371992 01:50:24 INFO - PROCESS | 9695 | |2;jquery.html;434.47211637859994;436.49366734587886;438.7893810970734;440.2032321498088;447.74044952744015;18340.17469213885;19520.707189392135;20099.497512562175;20250.29123980661;20575;16936.661266774656;18658.160382782775;19288.710669339936;19399.321023764172;19978.90010549945;5232.659877107985;5467.6719396836115;5476.315460567429;5476.479734425243;5478.342598888139;3995.840166393341;4449.710768800018;5386.91919621206;5422.620416570841;5441.673499590018;4659.184642687533;6762.087118239048;6765.932340676604;6768.255491895888;6768.42468390185;6033.306169790487;6081.483073938721;6179.721912513947;6740.595564266136;6751.392374686277;5873.383294754075;5899.351071382144;5914.112883067532;5919.644821310692;5920.437558431942;14165.433382664682;14216.92891535546;14445.638859028504;14564.927175364055;14575.781363279559;2189.2665956904457;2194.1771835561663;2500.6374075758913;2579.187555919898;2857.7570906472974;10217.540210690537;10290.7427314317;10325.84511232332;10786.352818830817;10832.40421776802;1829.9176537055864;1852.32212479274;1855.9072046397762;1859.33064096925;1867.6358110168524;83470;84143;84166.57916710377;84804;85508.57245713731;11487;11719.06247500198;11794.469248883821;11796.52813887435;11953.282803031845;16906.492805215865;16910.40813571519;16911.154442277835;16945.83054169467;16982.915085424494;8181.386396020203;8299.211574900375;8374.748757537283;8467.153284671484;8551.615177317035;7833.216678332121;7896;7926.841463170819;8013.038435387791;8098.959505202554;5015.924761128586;5057.266696329012;5058.3929928408825;5081.74591270435;5141.357330333708;1968.4193163016657;2052.332991777678;2062.236972320221;2125.7342832145982;2131.2753663754397;903.9245970456543;948.3124734567383;999.115782532464;999.7700528878398;1002.2533212756543;18943.43169704911;19948.70076948847;20032.298869539496;20055.197792088155;20062.398128056182;1000.2448151645461;1019.928604997643;1030.8711411073616;1060.6605886116522;1076.682378698286;10592.788144237073;11113.277636953571;11228.326300421837;11241.887581124247;11259.380734059541;450219;451275;453128;454153;460002;89873;91770.54114729384;92703;93727;93781.5310923441;1006.2704539209014;1030.6341248856547;1046.2571574182264;1051.0750539525168;1051.1748277602046;16435.424760133337;17054.317827287265;17684.789401324833;18092.547686307422;18158.5460363492;42504.78747606242;43055.78472107745;43241;43505;43567;56134.43865561292;56475;57264;57509.71245143915;58009.70995144997;11350.091992640404;12235.877641223475;12539.623811285312;12912.870871291167;13535.59393218205;14522.273886305431;14726.484573039892;14898.925505372405;14979.625509361917;15498.070115793089;12534.185277956904;12988.740225195254;12997.415116319598;13153.53962611304;13318.600441986757;12268.631941041784;12497.750044998867;12653.557125500563;12780.297083660487;13070.085094043327;12312;12522.812157817458;12646.936765316115;13196;13318.334083295991;12772.808407874076;12772.808407874076;12818.102732808615;13011.024173187237;13329.800052999406;12416;12465.563705270271;12584.370781461073;12871.678208044874;12933.09468337245 01:50:24 INFO - PROCESS | 9695 | |3;mootools.html;1385.7782754759241;1507.3292384888723;1532.1190315568547;1655.6274838161414;1859.0890463672797;7609.733659321925;8594.183552562512;8935.463872167675;8940.776480587972;8950.820983580332;8738.650453981832;8783.077776833436;8863.95568022159;8864.734057978254;8870.112988701143;2468.7654672806098;2493.6633554470095;2496.987515062422;2503.349129226396;2506.8746562671886;2456.7174774900845;2553.782928451084;2560.385507478201;2570.652961850145;2570.7429257074236;2423.369923819802;2425.9878700606473;2427.1262345555588;2431.9513609727883;2435.6224785158242;2362.598358279088;2363.1256435118944;2390.9043638254448;2427.6722642443397;2430.4774473488283;2417.347316224627;2425.042108367185;2442.658027876099;2454.055188752325;2454.7422520635255;8567.785805354853;8684.435511691783;8764.430312029697;8768.517731524764;8857.070007649232;5225.268462415265;5376.516113549799;5410.513053825174;5421.756020979065;5444.047291723972;3455.775374600643;3515.6132825389186;3590.551181102362;3618.7105031597407;3632.2735452909524;1133.4169596065249;1140.3841925360296;1199.5921386728555;1200.9879901200964;1205.1624121235745;11980.88019119815;12215.69460763488;12360.134790564663;12370.938145309216;12383.690407739788;4759.241016400405;4805.735684537384;4807;4830.758462076882;4879.731614761151;10404.219683523766;10408.219383546264;10411.323263987968;10428.5828566858;10428.843567346496;5518.751656175402;5523.033469142884;5524.558035357162;5525.751341189656;5527.309086364205;4369.71596846204;4447.977760111244;4500.144972455223;4889.3888263967;4928.802847886116;4187.350960601112;4229.281022226229;4247.4265974093105;4322.589354011364;4328;1334.5377777999574;1353.1948490648049;1366.8154799102192;1378.6070969773766;1406.1492796857958;919.5080631861922;1026.3944272879037;1034.9637762678421;1039.9688009359731;1045.6078970386104;6070.6357618543025;6094.6647934363145;6154.599951003171;6277.403646653561;6365.681715914186;433.1467009990314;442.2768773056076;444.19822220891604;446.25920971187674;999.6351331763999;4201.45381100455;4441.977790111029;4449.599536041772;4456.153330867125;4465.665075119379;10669.413182274895;10782.78434431307;10839.349639021526;10849.240553161202;10973.451327433597;10775;10782.029617334478;10790.73023174427;10805.783884322269;10838.512266948006;7804.609769511501;8108.391870609727;8136.75589732309;8272.37957153216;8292.17078292166;6063.302720187235;6079.756809727562;6123.7244324006415;6312.58968167086;6319.304876463493;9767.413955162712;9861.753456163653;9934.056264654846;10021.39871607706;10022.799544009225;9972.650957216463;10028.949855250678;10046.497675116361;10100.49497525106;10222.080012798884;7772.961135194514;7863.095743989515;7897.921020789719;7908.802279943047;8027.839443210986;8350.331973442231;8420.326373889951;8484.278836298983;8497.362697797565;8500.404971651926;7289.671964761705;7460.515066520658;7484.775456736306;7495.213002634863;7609.581473018816;7249.963750181215;7318.231585683427;7362.815929601588;7463.067116610424;7744.535327880345;6826.726930922708;6953.617551034742;6958.582485050913;6960.4779641526075;6966.164060312795;5327.440618734977;5453.672779633234;5480.342358916955;5489.807856724996;5590.043484780294;5490.423505531861;5541.196526503554;5558.194061860927;5581.553475721851;5615.410381910004 01:50:24 INFO - PROCESS | 9695 | |4;prototype.html;357.5173515753734;357.6405712259182;357.9284143171366;361.94751760994654;371.3538443108989;5367.329083864517;5416.972915135424;5425.538829199518;5427.1316589345715;5437.32033495813;5008.974955125219;5103.668261562996;5170.319646115018;5260.579153667707;5318.6011049171275;4208.684348673846;4236.703430759848;4250.893727656818;4282.7002109852165;4303.655707543405;4234.513031001444;4282.914341713164;4288.120935208291;4293.377460268259;4313.849015284466;3976;4002.1595464952393;4202.8232095013445;4224.746515209097;4267.354240370974;4203.495580530325;4206.894827629334;4231.682623803227;4232.174725928445;4233.407322974786;3780.4329350597354;3790.469334293201;3794.715396345285;3799.5060642116623;3805.3530899746834;5063.54428101469;5128.307678463397;5170;5279.25784491117;5284.445133261029;4834.879128021792;4836.177849765513;4838.250071238964;4844.055409195208;4860.031687166703;5583.246261754693;5583.916241256385;5584.134459158837;5585.469380408855;5617.915731264035;3918.452211376519;4077.2253271878544;4098.692598055158;4216.451861258017;4226.429432026698;5756.8848623027725;5798.565107616945;5802.564807639402;5825.621334613236;5852.707364631794;4156.501219853637;4160.646345060643;4161.97919010403;4171.853985110507;4201.894952626209;4155.792210389468;4193.412922190896;4203.285441474956;4261.637760790368;4262.87211383659;4764.2615394613895;4770.379850619467;4787.760611969387;4792.161371759928;4828;5594.328680558359;5601.943980560142;5610.354809196913;5624.21261023457;5629;1392.449982257023;1407.0150894373978;1428.1573871415915;1428.4857451317516;1438.280859570215;938.2400255792829;952.7618095476131;968.5786682793008;983.9458829764432;994.3536701144169;5171.2501687255135;5262.394824595144;5268.472143078464;5291.523762861361;5303.893922121536;5484.120836560837;5501.587380946445;5504.4770746778995;5525.889482210333;5534.252875861707;5069.290299358093;5190.403103643054;5195.558377537876;5211.687298762086;5242.7378631068295;2899.7535209507428;2903.82213339995;2912.810667306618;2916.912492625225;2918.3073817186405;5547.583931205176;5688.9759843227785;5689.971550142222;5706.343770466367;5708.771649134072;5550.639208451437;5561.304836895388;5562.610617256753;5581.107022876401;5620.522255608237;5690.430956904276;5701.3181111572185;5701.828945131652;5716.942830571724;5739.827805165852;5300.787968481218;5455.772451198449;5473.890522189614;5493.23094766741;5512.035393805988;5448.738773409149;5449.9562664001;5456.508914197741;5469.699166545878;5475.917861232005;5486.588505862156;5709.571782116275;5710.543811328084;5745.971270143623;5782.190493330853;3972.463717398114;4002.45966794479;4004.899877503086;4015.988008993255;4030.1939612077117;5488.69812160335;5499.202615620633;5513.228148059195;5522;5598.664080155204;5115.590752739847;5394.406615272238;5404.108322126962;5435.728213589384;5441.76215151984;5255.9211611825085;5318.734063296897;5322.627416080837;5358.758855851574;5391.220897103868;5250.422453530032;5316.760745766527;5343.839684809462;5360.142377219626;5501.174823776306;5498.80754173602;5585.497305242548;5598.21624972496;5607.102863541977;5608.663480191201;5438.564914806885;5473.534749546333;5479;5483.835484935458;5485.341758988788 01:50:24 INFO - PROCESS | 9695 | |5;yui.html;781.9648115834788;785.4776573578567;785.7446329942763;806.9031716194057;831.7546323834466;15240.771388429182;15832.841671583281;16362.918185409071;16478;16496.25766840492;13553;14704.779428308557;14995.325210365532;15016.099034057965;15024.774628380555;854.1373213054812;875.60160127142;877.6971944679076;879.0374539878823;879.705298724928;856.5160684213399;857.4555157474986;860.5654144656971;860.7374750701034;860.9913900861005;905.8052518708477;905.9048799876017;906.1844340093935;906.573910262179;906.6282824042144;897.7037577599376;898.2993265253081;901.567247721091;902.341290857671;903;667.1360588038453;667.9599224046573;668.5787953589207;668.6222284409293;668.7859884836854;13692.452301907912;13916.095453795471;13987.090839095426;14410;14576.854231457763;12486.466259199202;12698.111132220749;12870.742585148244;13121.803172952414;13381.933090334485;11169.609063682814;11186.776264474665;11193.944030279878;11209.159313051472;11444.14168937333;3748;3754.2116155607355;3801.2777572261457;3893.1824316893485;3897.4933258676474;57981.71009144969;58930.41069589292;59067.70466147642;63915;67284.65430691408;11965.162438629386;12182.725940984768;12264.938675306566;12275.2021118627;12375.443105060294;21463.356099317047;21483.78516214849;21620.675689864664;21663.783362166178;21975.23086691958;8628.26659733917;8780.648774048967;8802.647894084164;8929.598168082322;8987.325950553735;4991.575716064102;5062.7215503146945;5067.41724701664;5069.290299358093;5102.719350435762;3598.4602309653237;3715.6655900968503;3718.7768733876055;3720.4419337099653;3720.925581488355;648.4682560300508;667.659493658228;672.3948446398183;673.5487223560226;674.9628770417576;706.2584286499156;730.4193166432699;748.2779118150902;755.9546427214385;788.5938741548107;9287.210587100037;9416.10546998034;9485.146336829719;9640.276979226586;9972.850407243897;728.1262485017894;781.2382926646475;784.3293983644016;794.0788685125342;807.5356669914705;4435.445569303837;4652.860414187579;4750.311204875274;4778.95221047792;4822.8794280143275;68792.6560367205;88894.55552722195;90870.54564727267;93123;93208.53395732978;76653.23346766572;77645;79491;79911;82077.58961205155;48273.75863120732;48719.75640121777;58607.41392586019;59913.70043149844;69255.65372173107;10391.636292729718;10465.47672616351;10804.351738895692;11091.5563377464;11214.66356009321;45598.772006139756;45809.541904580525;47021.76489117533;48393;50050;37923.81038094792;38165.618343816204;43302.56697432986;61727;67873;12337.629871103882;12830.850305095624;12883.613491595268;12928.935355323163;13087.803682944574;14438.639034024234;14633;14946.252687365806;15101.093934363973;15184.696306074038;13109.868901310865;13521.661958451117;13658.931705341409;13836.515721949683;13877.236751978739;12859.485620575446;13268.80096798568;13489.527866524624;13524.391402387113;14749.041312314665;13893.444262229397;14136.575902722934;14162.008659393743;14324.856751432353;15561.610959726097;10218.963618505324;11057.170712196457;11155.498002590066;11192.272502287326;11253.49359278818;11263.831042534532;11390.25963312382;11429.942850285695;11491.712707182387;11539.19225654196 01:50:24 INFO - PROCESS | 9695 | __end_tp_report 01:50:24 INFO - PROCESS | 9695 | __start_cc_report 01:50:24 INFO - PROCESS | 9695 | _x_x_mozilla_cycle_collect,1063 01:50:24 INFO - PROCESS | 9695 | __end_cc_report 01:50:24 INFO - PROCESS | 9695 | __startTimestamp1483609824618__endTimestamp 01:50:24 INFO - PROCESS | 9695 | 01:50:24 INFO - PROCESS | 9695 | ------- Summary: start ------- 01:50:24 INFO - PROCESS | 9695 | Number of tests: 6 01:50:24 INFO - PROCESS | 9695 | 01:50:24 INFO - PROCESS | 9695 | [#0] dojo.html Cycles:165 Average:5622.72 Median:5814.62 stddev:633.04 (10.9%) stddev-sans-first:606.87 01:50:24 INFO - PROCESS | 9695 | Values: 3244.5 3291.6 3296.6 3298.9 3322.7 5603.5 5649.4 5681.2 5686.7 5697.9 5595.9 5649.7 5652.0 5654.2 5677.5 5073.9 5101.4 5109.6 5129.5 5158.4 5069.9 5072.5 5101.9 5196.1 5210.9 5171.9 5234.1 5241.9 5255.4 5270.3 5254.2 5261.1 5264.4 5270.8 5304.0 4943.3 5040.4 5146.0 5156.1 5218.0 5466.0 5515.9 5547.7 5559.2 5566.4 6052.5 6078.6 6083.7 6088.2 6092.0 5839.5 6126.8 6135.5 6154.4 6157.9 5515.5 5602.9 5670.4 5673.3 5704.3 6225.1 6248.5 6251.7 6256.2 6260.2 5737.5 5992.2 5993.4 6000.5 6005.6 5796.2 5952.5 5990.0 5993.5 6114.4 6018.2 6022.5 6030.4 6037.7 6088.2 5825.8 6071.3 6072.1 6072.8 6080.7 4561.4 4598.4 4611.7 4630.1 4634.8 4127.4 4136.8 4147.1 4169.2 4175.6 5734.9 5770.6 5774.7 5789.1 5803.6 5847.9 5897.6 6008.1 6069.2 6128.1 5812.5 5814.6 5815.4 5822.4 5843.5 5247.0 5294.6 5296.4 5298.3 5299.4 6084.7 6116.4 6174.9 6380.0 6393.0 5989.2 6070.3 6076.3 6094.9 6098.4 6281.3 6298.7 6299.6 6302.6 6310.1 5755.0 5803.0 5911.1 5958.5 5971.0 6008.4 6034.9 6061.2 6120.1 6137.8 5898.2 5940.9 5952.5 5953.5 5959.3 5688.7 5939.5 5942.9 5943.6 5961.0 5751.5 5796.6 5837.7 5853.6 5924.2 5953.1 5959.5 5963.0 5969.9 5978.7 5640.3 5693.3 5700.6 5791.7 5835.8 01:50:24 INFO - PROCESS | 9695 | 01:50:24 INFO - PROCESS | 9695 | [#1] ext.html Cycles:180 Average:59468.31 Median:37139.91 stddev:114103.49 (307.2%) stddev-sans-first:114337.94 01:50:24 INFO - PROCESS | 9695 | Values: 589.4 606.8 637.3 656.7 672.5 33339.8 36274.3 36331.5 36368.5 36519.3 36599.5 45181.0 45832.3 45980.3 49940.0 8698.2 8826.3 8830.1 8836.7 8837.7 8437.7 8661.9 8700.1 8783.0 8789.6 8640.3 10478.7 10722.7 10741.1 11120.4 10764.0 10833.2 10848.9 10849.3 10849.8 10634.8 10707.6 10707.9 10713.9 10714.1 44696.0 44855.8 44913.3 44942.8 45025.3 3489.6 3556.5 3779.2 3916.9 4370.2 31675.0 31702.4 31713.5 32081.7 32418.7 4429.2 4533.9 4559.7 4608.7 4684.4 350307.0 359727.0 364668.0 365212.0 366853.0 62939.4 63297.4 63299.0 63311.0 63318.7 40063.0 40679.4 40688.2 43481.8 67439.3 18656.8 18823.2 18854.2 18873.8 18875.9 14487.8 14551.7 14587.1 14593.3 14595.3 18348.4 18757.9 19638.2 20833.6 20981.7 7321.7 7491.3 7614.8 7694.6 7821.1 997.3 1085.3 1088.7 1132.9 1140.5 33406.5 33639.8 33815.7 34003.7 34448.8 1002.5 1119.7 1163.2 1167.6 1189.7 16459.4 17737.3 17755.6 18493.0 18520.4 538035.0 546326.0 548377.0 549850.0 549932.0 61347.7 62092.0 62165.7 62316.7 62360.4 1298.1 1348.9 1361.5 1412.9 1436.3 30486.7 34752.3 35347.0 37100.8 37179.0 57264.4 58557.1 58627.4 58739.7 58771.4 355757.0 358021.0 358682.0 359912.0 360910.0 29653.4 30571.7 31458.8 31594.8 31868.4 38033.8 50466.2 51012.5 55458.4 55730.2 40172.4 41283.4 42024.8 42507.8 43590.3 40227.0 41698.4 41866.0 41923.2 44739.8 43689.6 44028.3 44237.8 44254.0 44880.3 36526.0 38954.0 39077.1 39141.8 39351.0 29240.5 29511.1 29556.6 29951.9 29981.4 01:50:24 INFO - PROCESS | 9695 | 01:50:24 INFO - PROCESS | 9695 | [#2] jquery.html Cycles:180 Average:28418.98 Median:20005.60 stddev:75018.38 (375.0%) stddev-sans-first:75199.40 01:50:24 INFO - PROCESS | 9695 | Values: 434.5 436.5 438.8 440.2 447.7 18340.2 19520.7 20099.5 20250.3 20575.0 16936.7 18658.2 19288.7 19399.3 19978.9 5232.7 5467.7 5476.3 5476.5 5478.3 3995.8 4449.7 5386.9 5422.6 5441.7 4659.2 6762.1 6765.9 6768.3 6768.4 6033.3 6081.5 6179.7 6740.6 6751.4 5873.4 5899.4 5914.1 5919.6 5920.4 14165.4 14216.9 14445.6 14564.9 14575.8 2189.3 2194.2 2500.6 2579.2 2857.8 10217.5 10290.7 10325.8 10786.4 10832.4 1829.9 1852.3 1855.9 1859.3 1867.6 83470.0 84143.0 84166.6 84804.0 85508.6 11487.0 11719.1 11794.5 11796.5 11953.3 16906.5 16910.4 16911.2 16945.8 16982.9 8181.4 8299.2 8374.7 8467.2 8551.6 7833.2 7896.0 7926.8 8013.0 8099.0 5015.9 5057.3 5058.4 5081.7 5141.4 1968.4 2052.3 2062.2 2125.7 2131.3 903.9 948.3 999.1 999.8 1002.3 18943.4 19948.7 20032.3 20055.2 20062.4 1000.2 1019.9 1030.9 1060.7 1076.7 10592.8 11113.3 11228.3 11241.9 11259.4 450219.0 451275.0 453128.0 454153.0 460002.0 89873.0 91770.5 92703.0 93727.0 93781.5 1006.3 1030.6 1046.3 1051.1 1051.2 16435.4 17054.3 17684.8 18092.5 18158.5 42504.8 43055.8 43241.0 43505.0 43567.0 56134.4 56475.0 57264.0 57509.7 58009.7 11350.1 12235.9 12539.6 12912.9 13535.6 14522.3 14726.5 14898.9 14979.6 15498.1 12534.2 12988.7 12997.4 13153.5 13318.6 12268.6 12497.8 12653.6 12780.3 13070.1 12312.0 12522.8 12646.9 13196.0 13318.3 12772.8 12772.8 12818.1 13011.0 13329.8 12416.0 12465.6 12584.4 12871.7 12933.1 01:50:24 INFO - PROCESS | 9695 | 01:50:24 INFO - PROCESS | 9695 | [#3] mootools.html Cycles:180 Average:5853.25 Median:4482.91 stddev:3238.90 (72.3%) stddev-sans-first:3230.58 01:50:24 INFO - PROCESS | 9695 | Values: 1385.8 1507.3 1532.1 1655.6 1859.1 7609.7 8594.2 8935.5 8940.8 8950.8 8738.7 8783.1 8864.0 8864.7 8870.1 2468.8 2493.7 2497.0 2503.3 2506.9 2456.7 2553.8 2560.4 2570.7 2570.7 2423.4 2426.0 2427.1 2432.0 2435.6 2362.6 2363.1 2390.9 2427.7 2430.5 2417.3 2425.0 2442.7 2454.1 2454.7 8567.8 8684.4 8764.4 8768.5 8857.1 5225.3 5376.5 5410.5 5421.8 5444.0 3455.8 3515.6 3590.6 3618.7 3632.3 1133.4 1140.4 1199.6 1201.0 1205.2 11980.9 12215.7 12360.1 12370.9 12383.7 4759.2 4805.7 4807.0 4830.8 4879.7 10404.2 10408.2 10411.3 10428.6 10428.8 5518.8 5523.0 5524.6 5525.8 5527.3 4369.7 4448.0 4500.1 4889.4 4928.8 4187.4 4229.3 4247.4 4322.6 4328.0 1334.5 1353.2 1366.8 1378.6 1406.1 919.5 1026.4 1035.0 1040.0 1045.6 6070.6 6094.7 6154.6 6277.4 6365.7 433.1 442.3 444.2 446.3 999.6 4201.5 4442.0 4449.6 4456.2 4465.7 10669.4 10782.8 10839.3 10849.2 10973.5 10775.0 10782.0 10790.7 10805.8 10838.5 7804.6 8108.4 8136.8 8272.4 8292.2 6063.3 6079.8 6123.7 6312.6 6319.3 9767.4 9861.8 9934.1 10021.4 10022.8 9972.7 10028.9 10046.5 10100.5 10222.1 7773.0 7863.1 7897.9 7908.8 8027.8 8350.3 8420.3 8484.3 8497.4 8500.4 7289.7 7460.5 7484.8 7495.2 7609.6 7250.0 7318.2 7362.8 7463.1 7744.5 6826.7 6953.6 6958.6 6960.5 6966.2 5327.4 5453.7 5480.3 5489.8 5590.0 5490.4 5541.2 5558.2 5581.6 5615.4 01:50:24 INFO - PROCESS | 9695 | 01:50:24 INFO - PROCESS | 9695 | [#4] prototype.html Cycles:180 Average:4649.38 Median:5296.16 stddev:1326.80 (25.1%) stddev-sans-first:1290.83 01:50:24 INFO - PROCESS | 9695 | Values: 357.5 357.6 357.9 361.9 371.4 5367.3 5417.0 5425.5 5427.1 5437.3 5009.0 5103.7 5170.3 5260.6 5318.6 4208.7 4236.7 4250.9 4282.7 4303.7 4234.5 4282.9 4288.1 4293.4 4313.8 3976.0 4002.2 4202.8 4224.7 4267.4 4203.5 4206.9 4231.7 4232.2 4233.4 3780.4 3790.5 3794.7 3799.5 3805.4 5063.5 5128.3 5170.0 5279.3 5284.4 4834.9 4836.2 4838.3 4844.1 4860.0 5583.2 5583.9 5584.1 5585.5 5617.9 3918.5 4077.2 4098.7 4216.5 4226.4 5756.9 5798.6 5802.6 5825.6 5852.7 4156.5 4160.6 4162.0 4171.9 4201.9 4155.8 4193.4 4203.3 4261.6 4262.9 4764.3 4770.4 4787.8 4792.2 4828.0 5594.3 5601.9 5610.4 5624.2 5629.0 1392.4 1407.0 1428.2 1428.5 1438.3 938.2 952.8 968.6 983.9 994.4 5171.3 5262.4 5268.5 5291.5 5303.9 5484.1 5501.6 5504.5 5525.9 5534.3 5069.3 5190.4 5195.6 5211.7 5242.7 2899.8 2903.8 2912.8 2916.9 2918.3 5547.6 5689.0 5690.0 5706.3 5708.8 5550.6 5561.3 5562.6 5581.1 5620.5 5690.4 5701.3 5701.8 5716.9 5739.8 5300.8 5455.8 5473.9 5493.2 5512.0 5448.7 5450.0 5456.5 5469.7 5475.9 5486.6 5709.6 5710.5 5746.0 5782.2 3972.5 4002.5 4004.9 4016.0 4030.2 5488.7 5499.2 5513.2 5522.0 5598.7 5115.6 5394.4 5404.1 5435.7 5441.8 5255.9 5318.7 5322.6 5358.8 5391.2 5250.4 5316.8 5343.8 5360.1 5501.2 5498.8 5585.5 5598.2 5607.1 5608.7 5438.6 5473.5 5479.0 5483.8 5485.3 01:50:24 INFO - PROCESS | 9695 | 01:50:24 INFO - PROCESS | 9695 | [#5] yui.html Cycles:180 Average:17496.29 Median:25231.20 stddev:22449.17 (89.0%) stddev-sans-first:22477.06 01:50:24 INFO - PROCESS | 9695 | Values: 782.0 785.5 785.7 806.9 831.8 15240.8 15832.8 16362.9 16478.0 16496.3 13553.0 14704.8 14995.3 15016.1 15024.8 854.1 875.6 877.7 879.0 879.7 856.5 857.5 860.6 860.7 861.0 905.8 905.9 906.2 906.6 906.6 897.7 898.3 901.6 902.3 903.0 667.1 668.0 668.6 668.6 668.8 13692.5 13916.1 13987.1 14410.0 14576.9 12486.5 12698.1 12870.7 13121.8 13381.9 11169.6 11186.8 11193.9 11209.2 11444.1 3748.0 3754.2 3801.3 3893.2 3897.5 57981.7 58930.4 59067.7 63915.0 67284.7 11965.2 12182.7 12264.9 12275.2 12375.4 21463.4 21483.8 21620.7 21663.8 21975.2 8628.3 8780.6 8802.6 8929.6 8987.3 4991.6 5062.7 5067.4 5069.3 5102.7 3598.5 3715.7 3718.8 3720.4 3720.9 648.5 667.7 672.4 673.5 675.0 706.3 730.4 748.3 756.0 788.6 9287.2 9416.1 9485.1 9640.3 9972.9 728.1 781.2 784.3 794.1 807.5 4435.4 4652.9 4750.3 4779.0 4822.9 68792.7 88894.6 90870.5 93123.0 93208.5 76653.2 77645.0 79491.0 79911.0 82077.6 48273.8 48719.8 58607.4 59913.7 69255.7 10391.6 10465.5 10804.4 11091.6 11214.7 45598.8 45809.5 47021.8 48393.0 50050.0 37923.8 38165.6 43302.6 61727.0 67873.0 12337.6 12830.9 12883.6 12928.9 13087.8 14438.6 14633.0 14946.3 15101.1 15184.7 13109.9 13521.7 13658.9 13836.5 13877.2 12859.5 13268.8 13489.5 13524.4 14749.0 13893.4 14136.6 14162.0 14324.9 15561.6 10219.0 11057.2 11155.5 11192.3 11253.5 11263.8 11390.3 11429.9 11491.7 11539.2 01:50:24 INFO - PROCESS | 9695 | -------- Summary: end -------- 01:50:24 INFO - PROCESS | 9695 | 01:50:25 INFO - TEST-INFO | 9695: exit 0 01:50:25 INFO - TEST-OK | dromaeo_css | took 1115505ms 01:50:25 INFO - TEST-START | kraken 01:50:25 INFO - operating with platform_type : linux_ 01:50:25 INFO - Initialising browser for kraken test... 01:50:25 INFO - TEST-INFO | started process 10010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg1Bklz/profile http://localhost:34030/getInfo.html) 01:50:29 INFO - PROCESS | 10010 | __metrics Screen width/height:1600/1200 01:50:29 INFO - PROCESS | 10010 | colorDepth:24 01:50:29 INFO - PROCESS | 10010 | Browser inner width/height: 1024/697 01:50:29 INFO - PROCESS | 10010 | __metrics 01:50:30 INFO - PROCESS | 10010 | 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" 01:50:30 INFO - PROCESS | 10010 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:50:30 INFO - PROCESS | 10010 | console.error: PushService: 01:50:30 INFO - PROCESS | 10010 | stateChangeProcessEnqueue: Error transitioning state 01:50:30 INFO - PROCESS | 10010 | UnknownError 01:50:31 INFO - TEST-INFO | 10010: exit 0 01:50:31 INFO - Browser initialized. 01:50:31 INFO - Running cycle 1/1 for kraken test... 01:50:31 INFO - TEST-INFO | started process 10105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg1Bklz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:50:43 INFO - PROCESS | 10105 | RSS: Main: 144035840 01:50:43 INFO - PROCESS | 10105 | 01:50:45 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34030/tests/kraken/driver.html?testName=audio-beat-detection) 01:50:46 INFO - PROCESS | 10105 | RSS: Main: 184832000 01:50:46 INFO - PROCESS | 10105 | 01:50:48 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34030/tests/kraken/driver.html?testName=audio-dft) 01:50:49 INFO - PROCESS | 10105 | RSS: Main: 174133248 01:50:49 INFO - PROCESS | 10105 | 01:50:52 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34030/tests/kraken/driver.html?testName=audio-fft) 01:50:52 INFO - PROCESS | 10105 | RSS: Main: 266088448 01:50:52 INFO - PROCESS | 10105 | 01:50:54 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34030/tests/kraken/driver.html?testName=audio-oscillator) 01:50:55 INFO - PROCESS | 10105 | RSS: Main: 172396544 01:50:55 INFO - PROCESS | 10105 | 01:50:57 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34030/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:50:58 INFO - PROCESS | 10105 | RSS: Main: 174845952 01:50:58 INFO - PROCESS | 10105 | 01:51:01 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34030/tests/kraken/driver.html?testName=imaging-darkroom) 01:51:01 INFO - PROCESS | 10105 | RSS: Main: 214102016 01:51:01 INFO - PROCESS | 10105 | 01:51:05 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34030/tests/kraken/driver.html?testName=imaging-desaturate) 01:51:05 INFO - PROCESS | 10105 | RSS: Main: 213532672 01:51:05 INFO - PROCESS | 10105 | 01:51:08 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34030/tests/kraken/driver.html?testName=json-parse-financial) 01:51:08 INFO - PROCESS | 10105 | RSS: Main: 211603456 01:51:08 INFO - PROCESS | 10105 | 01:51:10 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34030/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:51:11 INFO - PROCESS | 10105 | RSS: Main: 173801472 01:51:11 INFO - PROCESS | 10105 | 01:51:12 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:51:13 INFO - PROCESS | 10105 | RSS: Main: 180125696 01:51:13 INFO - PROCESS | 10105 | 01:51:15 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:51:15 INFO - PROCESS | 10105 | RSS: Main: 188801024 01:51:15 INFO - PROCESS | 10105 | 01:51:18 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:51:19 INFO - PROCESS | 10105 | RSS: Main: 197771264 01:51:19 INFO - PROCESS | 10105 | 01:51:21 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:51:22 INFO - PROCESS | 10105 | RSS: Main: 194007040 01:51:22 INFO - PROCESS | 10105 | 01:51:23 INFO - PROCESS | 10105 | Cycle 1(1): loaded http://localhost:34030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34030/tests/kraken/driver.html?testName=ai-astar) 01:51:24 INFO - PROCESS | 10105 | RSS: Main: 244998144 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | __start_tp_report 01:51:24 INFO - PROCESS | 10105 | _x_x_mozilla_page_load 01:51:24 INFO - PROCESS | 10105 | _x_x_mozilla_page_load_details 01:51:24 INFO - PROCESS | 10105 | |i|pagename|runs| 01:51:24 INFO - PROCESS | 10105 | |0;ai-astar;102;111;109;111;112;110;111;111;112;111 01:51:24 INFO - PROCESS | 10105 | |1;audio-beat-detection;140;117;117;157;118;117;118;117;146;119 01:51:24 INFO - PROCESS | 10105 | |2;audio-dft;162;161;161;160;158;161;158;159;160;160 01:51:24 INFO - PROCESS | 10105 | |3;audio-fft;75;74;75;110;75;77;76;76;102;78 01:51:24 INFO - PROCESS | 10105 | |4;audio-oscillator;82;81;109;82;82;84;100;81;81;118 01:51:24 INFO - PROCESS | 10105 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;117;117;117 01:51:24 INFO - PROCESS | 10105 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;146;146 01:51:24 INFO - PROCESS | 10105 | |7;imaging-desaturate;84;85;84;85;84;84;85;85;85;84 01:51:24 INFO - PROCESS | 10105 | |8;json-parse-financial;51;57;50;49;51;51;49;49;50;49 01:51:24 INFO - PROCESS | 10105 | |9;json-stringify-tinderbox;58;59;59;59;60;59;59;59;59;60 01:51:24 INFO - PROCESS | 10105 | |10;stanford-crypto-aes;76;75;82;74;78;81;76;75;81;76 01:51:24 INFO - PROCESS | 10105 | |11;stanford-crypto-ccm;123;123;129;126;122;126;119;120;174;122 01:51:24 INFO - PROCESS | 10105 | |12;stanford-crypto-pbkdf2;153;151;151;150;151;152;155;154;153;153 01:51:24 INFO - PROCESS | 10105 | |13;stanford-crypto-sha256-iterative;63;63;63;64;64;62;65;61;60;59 01:51:24 INFO - PROCESS | 10105 | __end_tp_report 01:51:24 INFO - PROCESS | 10105 | __start_cc_report 01:51:24 INFO - PROCESS | 10105 | _x_x_mozilla_cycle_collect,1622 01:51:24 INFO - PROCESS | 10105 | __end_cc_report 01:51:24 INFO - PROCESS | 10105 | __startTimestamp1483609884245__endTimestamp 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | ------- Summary: start ------- 01:51:24 INFO - PROCESS | 10105 | Number of tests: 14 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.94 (2.7%) stddev-sans-first:0.93 01:51:24 INFO - PROCESS | 10105 | Values: 102.0 111.0 109.0 111.0 112.0 110.0 111.0 111.0 112.0 111.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:118.50 stddev:15.11 (12.7%) stddev-sans-first:15.23 01:51:24 INFO - PROCESS | 10105 | Values: 140.0 117.0 117.0 157.0 118.0 117.0 118.0 117.0 146.0 119.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.50 stddev:1.33 (0.8%) stddev-sans-first:1.20 01:51:24 INFO - PROCESS | 10105 | Values: 162.0 161.0 161.0 160.0 158.0 161.0 158.0 159.0 160.0 160.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:12.94 (17.1%) stddev-sans-first:13.49 01:51:24 INFO - PROCESS | 10105 | Values: 75.0 74.0 75.0 110.0 75.0 77.0 76.0 76.0 102.0 78.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:81.50 stddev:13.81 (16.9%) stddev-sans-first:14.34 01:51:24 INFO - PROCESS | 10105 | Values: 82.0 81.0 109.0 82.0 82.0 84.0 100.0 81.0 81.0 118.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 01:51:24 INFO - PROCESS | 10105 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 01:51:24 INFO - PROCESS | 10105 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 01:51:24 INFO - PROCESS | 10105 | Values: 84.0 85.0 84.0 85.0 84.0 84.0 85.0 85.0 85.0 84.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.50 stddev:2.41 (4.8%) stddev-sans-first:2.55 01:51:24 INFO - PROCESS | 10105 | Values: 51.0 57.0 50.0 49.0 51.0 51.0 49.0 49.0 50.0 49.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 01:51:24 INFO - PROCESS | 10105 | Values: 58.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:77.00 stddev:2.91 (3.8%) stddev-sans-first:3.05 01:51:24 INFO - PROCESS | 10105 | Values: 76.0 75.0 82.0 74.0 78.0 81.0 76.0 75.0 81.0 76.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:124.50 stddev:16.30 (13.1%) stddev-sans-first:17.17 01:51:24 INFO - PROCESS | 10105 | Values: 123.0 123.0 129.0 126.0 122.0 126.0 119.0 120.0 174.0 122.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:153.00 stddev:1.57 (1.0%) stddev-sans-first:1.64 01:51:24 INFO - PROCESS | 10105 | Values: 153.0 151.0 151.0 150.0 151.0 152.0 155.0 154.0 153.0 153.0 01:51:24 INFO - PROCESS | 10105 | 01:51:24 INFO - PROCESS | 10105 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:1.90 (3.0%) stddev-sans-first:2.00 01:51:24 INFO - PROCESS | 10105 | Values: 63.0 63.0 63.0 64.0 64.0 62.0 65.0 61.0 60.0 59.0 01:51:24 INFO - PROCESS | 10105 | -------- Summary: end -------- 01:51:24 INFO - PROCESS | 10105 | 01:51:25 INFO - TEST-INFO | 10105: exit 0 01:51:25 INFO - TEST-OK | kraken | took 59935ms 01:51:25 INFO - SUITE-END | took 1175s 01:51:25 INFO - Completed test suite (00:19:35) 01:51:25 INFO - javascript benchmark 01:51:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3244.497102949043, 3291.6050073991123, 3296.604407471103, 3298.884539041134, 3322.717569006634, 5603.467670571295, 5649.406812284702, 5681.204631351614, 5686.658800471974, 5697.886042279157, 5595.916061259084, 5649.689267090308, 5652.0391533439315, 5654.208410822488, 5677.545796336293, 5073.873153171173, 5101.438841727407, 5109.591232701375, 5129.461406552315, 5158.432572417031, 5069.949300506984, 5072.543471087602, 5101.897962040757, 5196.116660167761, 5210.921836172461, 5171.922421163686, 5234.110201265794, 5241.868953276179, 5255.421903590602, 5270.314859068316, 5254.211868219798, 5261.079311120558, 5264.42091369949, 5270.789168433277, 5304.0, 4943.258511223309, 5040.42035165957, 5146.0, 5156.097682905514, 5218.034663587248, 5466.043442397565, 5515.862103447405, 5547.694876781776, 5559.19391688207, 5566.387697353288, 6052.485538729214, 6078.6048906820915, 6083.726232319512, 6088.208532890741, 6091.969540152315, 5839.532837373043, 6126.754929802847, 6135.478484328793, 6154.384561543855, 6157.907631385533, 5515.503604675559, 5602.915956260659, 5670.404607516234, 5673.347565030074, 5704.315482142087, 6225.128482012522, 6248.50011999039, 6251.687415629201, 6256.249250090018, 6260.217472815898, 5737.454941780524, 5992.221011268507, 5993.400659933972, 6000.459958603659, 6005.6396616203165, 5796.246487956539, 5952.494038006731, 5989.970050149808, 5993.460588547052, 6114.38856114385, 6018.21763170785, 6022.45797878193, 6030.396960304022, 6037.72830222641, 6088.238970128734, 5825.825225243249, 6071.301800293023, 6072.089186622042, 6072.817815465543, 6080.69596520181, 4561.429821272341, 4598.425196850394, 4611.677182597186, 4630.050839577879, 4634.791434385461, 4127.442795222607, 4136.772477513766, 4147.149834283965, 4169.1661667666585, 4175.561566035583, 5734.856628584319, 5770.6249093808765, 5774.711264436762, 5789.131630255495, 5803.622764520293, 5847.912281315784, 5897.64614123154, 6008.09878518217, 6069.241344831896, 6128.080787881764, 5812.534997200214, 5814.622049566765, 5815.41845815415, 5822.417758224144, 5843.5325173985975, 5247.02929957959, 5294.629375943647, 5296.443873393316, 5298.258243845788, 5299.364076310867, 6084.69576521181, 6116.396640261158, 6174.876502469836, 6379.968100159563, 6393.0, 5989.191459153133, 6070.271567411939, 6076.331603523698, 6094.878102438015, 6098.390160983866, 6281.277653069773, 6298.685065746786, 6299.622022678654, 6302.5588208826775, 6310.11658367838, 5755.021646320052, 5803.0, 5911.142884281841, 5958.493528049991, 5970.996876510074, 6008.369121242206, 6034.909476357946, 6061.1514387984835, 6120.143179954899, 6137.7851775187655, 5898.203742494708, 5940.940590594211, 5952.494038006818, 5953.464188223081, 5959.344472108151, 5688.715564221855, 5939.46544810969, 5942.851428714317, 5943.613665111754, 5961.0, 5751.539876809761, 5796.59423840344, 5837.737301821513, 5853.619514731528, 5924.229850119457, 5953.10703394477, 5959.463648271676, 5962.970185149046, 5969.850753731192, 5978.671173085522, 5640.323161220515, 5693.259876216231, 5700.572457065819, 5791.739371728198, 5835.766569337179], "value": 5580.485932864381, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.4488653109343, 606.8045949479526, 637.3021541412154, 656.6749459017786, 672.5258692621702, 33339.833300833496, 36274.27451450969, 36331.45502817457, 36368.45447318286, 36519.26961460769, 36599.4510082349, 45181.0, 45832.3125153123, 45980.310295345516, 49940.0, 8698.173673501024, 8826.338024648145, 8830.11698830115, 8836.734897953073, 8837.690680826172, 8437.746867593982, 8661.870071948895, 8700.086490918457, 8783.0, 8789.560521973908, 8640.265577425926, 10478.685639430829, 10722.731931701692, 10741.140708743322, 11120.443977801118, 10764.031237188652, 10833.241673082888, 10848.945755271252, 10849.349039057683, 10849.83725244118, 10634.840477392845, 10707.625233116803, 10707.946460267727, 10713.892861071368, 10714.142868570496, 44696.0, 44855.775721121514, 44913.326300105524, 44942.77528612369, 45025.32462013073, 3489.6335884732243, 3556.5020897074432, 3779.1874746929543, 3916.8824935251705, 4370.169667763115, 31675.0, 31702.36595268082, 31713.524297135562, 32081.679183208103, 32418.6758132418, 4429.158459892642, 4533.909321813579, 4559.726416415026, 4608.700434471749, 4684.36761037259, 350307.0, 359727.0, 364668.0, 365212.0, 366853.0, 62939.370606294266, 63297.36702632915, 63299.0, 63311.0, 63318.68340658267, 40063.0, 40679.38980915289, 40688.186236275105, 43481.782591087474, 67439.32560674331, 18656.813431865507, 18823.247070117042, 18854.245830166914, 18873.81126188748, 18875.90562047181, 14487.78268325976, 14551.708965820624, 14587.124772513684, 14593.270336483134, 14595.343209555384, 18348.357807476674, 18757.90621046886, 19638.21447142127, 20833.58332833335, 20981.68527472089, 7321.74373896911, 7491.288327608869, 7614.847703046019, 7694.615269236516, 7821.100573434014, 997.3168379659957, 1085.2945585369416, 1088.684281558355, 1132.9433528323716, 1140.5152810055692, 33406.49890251648, 33639.83180084084, 33815.661843381255, 34003.65996340055, 34448.82775586106, 1002.4536627538009, 1119.658504156224, 1163.1799581295168, 1167.5913430299327, 1189.726362936512, 16459.423920162975, 17737.290508379778, 17755.556111097325, 18493.0, 18520.444386668423, 538035.0, 546326.0, 548377.0, 549850.0, 549932.0, 61347.69326153341, 62092.0, 62165.68917155385, 62316.68841655763, 62360.37639623637, 1298.1172802494207, 1348.9460421583224, 1361.5438827992734, 1412.9364178611986, 1436.2818590704649, 30486.695133048386, 34752.304953901286, 35347.0, 37100.81449592735, 37179.0, 57264.42735572591, 58557.12164317624, 58627.41372586219, 58739.70630146822, 58771.41228587659, 355757.0, 358021.0, 358682.0, 359912.0, 360910.0, 29653.406931861675, 30571.694283056884, 31458.842705786323, 31594.842025789723, 31868.362632747678, 38033.80983095067, 50466.2430063542, 51012.48987510077, 55458.44541554694, 55730.16404754013, 40172.3974140394, 41283.38074928938, 42024.789876050425, 42507.7874610625, 43590.34614480722, 40227.0, 41698.37452438155, 41866.0, 41923.1615367697, 44739.77630111828, 43689.56310436855, 44028.33957490576, 44237.77881110574, 44254.0, 44880.32679509745, 36526.0, 38954.04672455358, 39077.06534222312, 39141.80429097836, 39351.0, 29240.528371352353, 29511.11466656004, 29556.556651650673, 29951.850240748656, 29981.400371992], "value": 20932.17121352587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.47211637859994, 436.49366734587886, 438.7893810970734, 440.2032321498088, 447.74044952744015, 18340.17469213885, 19520.707189392135, 20099.497512562175, 20250.29123980661, 20575.0, 16936.661266774656, 18658.160382782775, 19288.710669339936, 19399.321023764172, 19978.90010549945, 5232.659877107985, 5467.6719396836115, 5476.315460567429, 5476.479734425243, 5478.342598888139, 3995.840166393341, 4449.710768800018, 5386.91919621206, 5422.620416570841, 5441.673499590018, 4659.184642687533, 6762.087118239048, 6765.932340676604, 6768.255491895888, 6768.42468390185, 6033.306169790487, 6081.483073938721, 6179.721912513947, 6740.595564266136, 6751.392374686277, 5873.383294754075, 5899.351071382144, 5914.112883067532, 5919.644821310692, 5920.437558431942, 14165.433382664682, 14216.92891535546, 14445.638859028504, 14564.927175364055, 14575.781363279559, 2189.2665956904457, 2194.1771835561663, 2500.6374075758913, 2579.187555919898, 2857.7570906472974, 10217.540210690537, 10290.7427314317, 10325.84511232332, 10786.352818830817, 10832.40421776802, 1829.9176537055864, 1852.32212479274, 1855.9072046397762, 1859.33064096925, 1867.6358110168524, 83470.0, 84143.0, 84166.57916710377, 84804.0, 85508.57245713731, 11487.0, 11719.06247500198, 11794.469248883821, 11796.52813887435, 11953.282803031845, 16906.492805215865, 16910.40813571519, 16911.154442277835, 16945.83054169467, 16982.915085424494, 8181.386396020203, 8299.211574900375, 8374.748757537283, 8467.153284671484, 8551.615177317035, 7833.216678332121, 7896.0, 7926.841463170819, 8013.038435387791, 8098.959505202554, 5015.924761128586, 5057.266696329012, 5058.3929928408825, 5081.74591270435, 5141.357330333708, 1968.4193163016657, 2052.332991777678, 2062.236972320221, 2125.7342832145982, 2131.2753663754397, 903.9245970456543, 948.3124734567383, 999.115782532464, 999.7700528878398, 1002.2533212756543, 18943.43169704911, 19948.70076948847, 20032.298869539496, 20055.197792088155, 20062.398128056182, 1000.2448151645461, 1019.928604997643, 1030.8711411073616, 1060.6605886116522, 1076.682378698286, 10592.788144237073, 11113.277636953571, 11228.326300421837, 11241.887581124247, 11259.380734059541, 450219.0, 451275.0, 453128.0, 454153.0, 460002.0, 89873.0, 91770.54114729384, 92703.0, 93727.0, 93781.5310923441, 1006.2704539209014, 1030.6341248856547, 1046.2571574182264, 1051.0750539525168, 1051.1748277602046, 16435.424760133337, 17054.317827287265, 17684.789401324833, 18092.547686307422, 18158.5460363492, 42504.78747606242, 43055.78472107745, 43241.0, 43505.0, 43567.0, 56134.43865561292, 56475.0, 57264.0, 57509.71245143915, 58009.70995144997, 11350.091992640404, 12235.877641223475, 12539.623811285312, 12912.870871291167, 13535.59393218205, 14522.273886305431, 14726.484573039892, 14898.925505372405, 14979.625509361917, 15498.070115793089, 12534.185277956904, 12988.740225195254, 12997.415116319598, 13153.53962611304, 13318.600441986757, 12268.631941041784, 12497.750044998867, 12653.557125500563, 12780.297083660487, 13070.085094043327, 12312.0, 12522.812157817458, 12646.936765316115, 13196.0, 13318.334083295991, 12772.808407874076, 12772.808407874076, 12818.102732808615, 13011.024173187237, 13329.800052999406, 12416.0, 12465.563705270271, 12584.370781461073, 12871.678208044874, 12933.09468337245], "value": 9596.233405013963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.7782754759241, 1507.3292384888723, 1532.1190315568547, 1655.6274838161414, 1859.0890463672797, 7609.733659321925, 8594.183552562512, 8935.463872167675, 8940.776480587972, 8950.820983580332, 8738.650453981832, 8783.077776833436, 8863.95568022159, 8864.734057978254, 8870.112988701143, 2468.7654672806098, 2493.6633554470095, 2496.987515062422, 2503.349129226396, 2506.8746562671886, 2456.7174774900845, 2553.782928451084, 2560.385507478201, 2570.652961850145, 2570.7429257074236, 2423.369923819802, 2425.9878700606473, 2427.1262345555588, 2431.9513609727883, 2435.6224785158242, 2362.598358279088, 2363.1256435118944, 2390.9043638254448, 2427.6722642443397, 2430.4774473488283, 2417.347316224627, 2425.042108367185, 2442.658027876099, 2454.055188752325, 2454.7422520635255, 8567.785805354853, 8684.435511691783, 8764.430312029697, 8768.517731524764, 8857.070007649232, 5225.268462415265, 5376.516113549799, 5410.513053825174, 5421.756020979065, 5444.047291723972, 3455.775374600643, 3515.6132825389186, 3590.551181102362, 3618.7105031597407, 3632.2735452909524, 1133.4169596065249, 1140.3841925360296, 1199.5921386728555, 1200.9879901200964, 1205.1624121235745, 11980.88019119815, 12215.69460763488, 12360.134790564663, 12370.938145309216, 12383.690407739788, 4759.241016400405, 4805.735684537384, 4807.0, 4830.758462076882, 4879.731614761151, 10404.219683523766, 10408.219383546264, 10411.323263987968, 10428.5828566858, 10428.843567346496, 5518.751656175402, 5523.033469142884, 5524.558035357162, 5525.751341189656, 5527.309086364205, 4369.71596846204, 4447.977760111244, 4500.144972455223, 4889.3888263967, 4928.802847886116, 4187.350960601112, 4229.281022226229, 4247.4265974093105, 4322.589354011364, 4328.0, 1334.5377777999574, 1353.1948490648049, 1366.8154799102192, 1378.6070969773766, 1406.1492796857958, 919.5080631861922, 1026.3944272879037, 1034.9637762678421, 1039.9688009359731, 1045.6078970386104, 6070.6357618543025, 6094.6647934363145, 6154.599951003171, 6277.403646653561, 6365.681715914186, 433.1467009990314, 442.2768773056076, 444.19822220891604, 446.25920971187674, 999.6351331763999, 4201.45381100455, 4441.977790111029, 4449.599536041772, 4456.153330867125, 4465.665075119379, 10669.413182274895, 10782.78434431307, 10839.349639021526, 10849.240553161202, 10973.451327433597, 10775.0, 10782.029617334478, 10790.73023174427, 10805.783884322269, 10838.512266948006, 7804.609769511501, 8108.391870609727, 8136.75589732309, 8272.37957153216, 8292.17078292166, 6063.302720187235, 6079.756809727562, 6123.7244324006415, 6312.58968167086, 6319.304876463493, 9767.413955162712, 9861.753456163653, 9934.056264654846, 10021.39871607706, 10022.799544009225, 9972.650957216463, 10028.949855250678, 10046.497675116361, 10100.49497525106, 10222.080012798884, 7772.961135194514, 7863.095743989515, 7897.921020789719, 7908.802279943047, 8027.839443210986, 8350.331973442231, 8420.326373889951, 8484.278836298983, 8497.362697797565, 8500.404971651926, 7289.671964761705, 7460.515066520658, 7484.775456736306, 7495.213002634863, 7609.581473018816, 7249.963750181215, 7318.231585683427, 7362.815929601588, 7463.067116610424, 7744.535327880345, 6826.726930922708, 6953.617551034742, 6958.582485050913, 6960.4779641526075, 6966.164060312795, 5327.440618734977, 5453.672779633234, 5480.342358916955, 5489.807856724996, 5590.043484780294, 5490.423505531861, 5541.196526503554, 5558.194061860927, 5581.553475721851, 5615.410381910004], "value": 4682.37616904762, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.5173515753734, 357.6405712259182, 357.9284143171366, 361.94751760994654, 371.3538443108989, 5367.329083864517, 5416.972915135424, 5425.538829199518, 5427.1316589345715, 5437.32033495813, 5008.974955125219, 5103.668261562996, 5170.319646115018, 5260.579153667707, 5318.6011049171275, 4208.684348673846, 4236.703430759848, 4250.893727656818, 4282.7002109852165, 4303.655707543405, 4234.513031001444, 4282.914341713164, 4288.120935208291, 4293.377460268259, 4313.849015284466, 3976.0, 4002.1595464952393, 4202.8232095013445, 4224.746515209097, 4267.354240370974, 4203.495580530325, 4206.894827629334, 4231.682623803227, 4232.174725928445, 4233.407322974786, 3780.4329350597354, 3790.469334293201, 3794.715396345285, 3799.5060642116623, 3805.3530899746834, 5063.54428101469, 5128.307678463397, 5170.0, 5279.25784491117, 5284.445133261029, 4834.879128021792, 4836.177849765513, 4838.250071238964, 4844.055409195208, 4860.031687166703, 5583.246261754693, 5583.916241256385, 5584.134459158837, 5585.469380408855, 5617.915731264035, 3918.452211376519, 4077.2253271878544, 4098.692598055158, 4216.451861258017, 4226.429432026698, 5756.8848623027725, 5798.565107616945, 5802.564807639402, 5825.621334613236, 5852.707364631794, 4156.501219853637, 4160.646345060643, 4161.97919010403, 4171.853985110507, 4201.894952626209, 4155.792210389468, 4193.412922190896, 4203.285441474956, 4261.637760790368, 4262.87211383659, 4764.2615394613895, 4770.379850619467, 4787.760611969387, 4792.161371759928, 4828.0, 5594.328680558359, 5601.943980560142, 5610.354809196913, 5624.21261023457, 5629.0, 1392.449982257023, 1407.0150894373978, 1428.1573871415915, 1428.4857451317516, 1438.280859570215, 938.2400255792829, 952.7618095476131, 968.5786682793008, 983.9458829764432, 994.3536701144169, 5171.2501687255135, 5262.394824595144, 5268.472143078464, 5291.523762861361, 5303.893922121536, 5484.120836560837, 5501.587380946445, 5504.4770746778995, 5525.889482210333, 5534.252875861707, 5069.290299358093, 5190.403103643054, 5195.558377537876, 5211.687298762086, 5242.7378631068295, 2899.7535209507428, 2903.82213339995, 2912.810667306618, 2916.912492625225, 2918.3073817186405, 5547.583931205176, 5688.9759843227785, 5689.971550142222, 5706.343770466367, 5708.771649134072, 5550.639208451437, 5561.304836895388, 5562.610617256753, 5581.107022876401, 5620.522255608237, 5690.430956904276, 5701.3181111572185, 5701.828945131652, 5716.942830571724, 5739.827805165852, 5300.787968481218, 5455.772451198449, 5473.890522189614, 5493.23094766741, 5512.035393805988, 5448.738773409149, 5449.9562664001, 5456.508914197741, 5469.699166545878, 5475.917861232005, 5486.588505862156, 5709.571782116275, 5710.543811328084, 5745.971270143623, 5782.190493330853, 3972.463717398114, 4002.45966794479, 4004.899877503086, 4015.988008993255, 4030.1939612077117, 5488.69812160335, 5499.202615620633, 5513.228148059195, 5522.0, 5598.664080155204, 5115.590752739847, 5394.406615272238, 5404.108322126962, 5435.728213589384, 5441.76215151984, 5255.9211611825085, 5318.734063296897, 5322.627416080837, 5358.758855851574, 5391.220897103868, 5250.422453530032, 5316.760745766527, 5343.839684809462, 5360.142377219626, 5501.174823776306, 5498.80754173602, 5585.497305242548, 5598.21624972496, 5607.102863541977, 5608.663480191201, 5438.564914806885, 5473.534749546333, 5479.0, 5483.835484935458, 5485.341758988788], "value": 4234.31605799776, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.9648115834788, 785.4776573578567, 785.7446329942763, 806.9031716194057, 831.7546323834466, 15240.771388429182, 15832.841671583281, 16362.918185409071, 16478.0, 16496.25766840492, 13553.0, 14704.779428308557, 14995.325210365532, 15016.099034057965, 15024.774628380555, 854.1373213054812, 875.60160127142, 877.6971944679076, 879.0374539878823, 879.705298724928, 856.5160684213399, 857.4555157474986, 860.5654144656971, 860.7374750701034, 860.9913900861005, 905.8052518708477, 905.9048799876017, 906.1844340093935, 906.573910262179, 906.6282824042144, 897.7037577599376, 898.2993265253081, 901.567247721091, 902.341290857671, 903.0, 667.1360588038453, 667.9599224046573, 668.5787953589207, 668.6222284409293, 668.7859884836854, 13692.452301907912, 13916.095453795471, 13987.090839095426, 14410.0, 14576.854231457763, 12486.466259199202, 12698.111132220749, 12870.742585148244, 13121.803172952414, 13381.933090334485, 11169.609063682814, 11186.776264474665, 11193.944030279878, 11209.159313051472, 11444.14168937333, 3748.0, 3754.2116155607355, 3801.2777572261457, 3893.1824316893485, 3897.4933258676474, 57981.71009144969, 58930.41069589292, 59067.70466147642, 63915.0, 67284.65430691408, 11965.162438629386, 12182.725940984768, 12264.938675306566, 12275.2021118627, 12375.443105060294, 21463.356099317047, 21483.78516214849, 21620.675689864664, 21663.783362166178, 21975.23086691958, 8628.26659733917, 8780.648774048967, 8802.647894084164, 8929.598168082322, 8987.325950553735, 4991.575716064102, 5062.7215503146945, 5067.41724701664, 5069.290299358093, 5102.719350435762, 3598.4602309653237, 3715.6655900968503, 3718.7768733876055, 3720.4419337099653, 3720.925581488355, 648.4682560300508, 667.659493658228, 672.3948446398183, 673.5487223560226, 674.9628770417576, 706.2584286499156, 730.4193166432699, 748.2779118150902, 755.9546427214385, 788.5938741548107, 9287.210587100037, 9416.10546998034, 9485.146336829719, 9640.276979226586, 9972.850407243897, 728.1262485017894, 781.2382926646475, 784.3293983644016, 794.0788685125342, 807.5356669914705, 4435.445569303837, 4652.860414187579, 4750.311204875274, 4778.95221047792, 4822.8794280143275, 68792.6560367205, 88894.55552722195, 90870.54564727267, 93123.0, 93208.53395732978, 76653.23346766572, 77645.0, 79491.0, 79911.0, 82077.58961205155, 48273.75863120732, 48719.75640121777, 58607.41392586019, 59913.70043149844, 69255.65372173107, 10391.636292729718, 10465.47672616351, 10804.351738895692, 11091.5563377464, 11214.66356009321, 45598.772006139756, 45809.541904580525, 47021.76489117533, 48393.0, 50050.0, 37923.81038094792, 38165.618343816204, 43302.56697432986, 61727.0, 67873.0, 12337.629871103882, 12830.850305095624, 12883.613491595268, 12928.935355323163, 13087.803682944574, 14438.639034024234, 14633.0, 14946.252687365806, 15101.093934363973, 15184.696306074038, 13109.868901310865, 13521.661958451117, 13658.931705341409, 13836.515721949683, 13877.236751978739, 12859.485620575446, 13268.80096798568, 13489.527866524624, 13524.391402387113, 14749.041312314665, 13893.444262229397, 14136.575902722934, 14162.008659393743, 14324.856751432353, 15561.610959726097, 10218.963618505324, 11057.170712196457, 11155.498002590066, 11192.272502287326, 11253.49359278818, 11263.831042534532, 11390.25963312382, 11429.942850285695, 11491.712707182387, 11539.19225654196], "value": 7382.064510326937, "unit": "score"}], "name": "dromaeo_css", "value": 7399.062841772317, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 109.0, 111.0, 112.0, 110.0, 111.0, 111.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 117.0, 117.0, 157.0, 118.0, 117.0, 118.0, 117.0, 146.0, 119.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 158.0, 161.0, 158.0, 159.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 110.0, 75.0, 77.0, 76.0, 76.0, 102.0, 78.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 109.0, 82.0, 82.0, 84.0, 100.0, 81.0, 81.0, 118.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 57.0, 50.0, 49.0, 51.0, 51.0, 49.0, 49.0, 50.0, 49.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 82.0, 74.0, 78.0, 81.0, 76.0, 75.0, 81.0, 76.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 129.0, 126.0, 122.0, 126.0, 119.0, 120.0, 174.0, 122.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 151.0, 150.0, 151.0, 152.0, 155.0, 154.0, 153.0, 153.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 62.0, 65.0, 61.0, 60.0, 59.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1445.7000000000003, "alertThreshold": 2.0}]} 01:51:25 INFO - Return code: 0 01:51:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:51:25 INFO - # TBPL SUCCESS # 01:51:25 INFO - Running post-action listener: _resource_record_post_action 01:51:25 INFO - [mozharness: 2017-01-05 09:51:25.552544Z] Finished run-tests step (success) 01:51:25 INFO - Running post-run listener: _resource_record_post_run 01:51:25 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 262144; Write bytes: 354729984; Read time: 16; Write time: 203640 01:51:25 INFO - TinderboxPrint: CPU usage
13.0% 01:51:25 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 16 01:51:25 INFO - TinderboxPrint: I/O write bytes / time
354,729,984 / 203,640 01:51:25 INFO - TinderboxPrint: CPU idle
8,275.7 (87.0%) 01:51:25 INFO - TinderboxPrint: CPU user
1,193.4 (12.5%) 01:51:25 INFO - TinderboxPrint: Swap in / out
0 / 0 01:51:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107896832; Read time: 0; Write time: 88804 01:51:25 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246833152; Read time: 16; Write time: 114836 01:51:26 INFO - Running post-run listener: _upload_blobber_files 01:51:26 INFO - Blob upload gear active. 01:51:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:51:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:51:26 INFO - (blobuploader) - INFO - Open directory for files ... 01:51:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:51:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:51:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:51:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:51:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:51:30 INFO - (blobuploader) - INFO - Done attempting. 01:51:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:51:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:51:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:51:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:51:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:51:31 INFO - (blobuploader) - INFO - Done attempting. 01:51:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:51:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:51:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:51:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:51:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:51:32 INFO - (blobuploader) - INFO - Done attempting. 01:51:32 INFO - (blobuploader) - INFO - Iteration through files over. 01:51:32 INFO - Return code: 0 01:51:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:51:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:51:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17ee58de68a028f8fecae44b025375a85c8e06201f354fff6aab2f334feb63055a082bb11c0319aa20313b638c6831300d3671e330b1fd47c43b2edf5ff7bb5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e3754e8dba32ee02030c103110e3893a485bbb4eaf1b06ff4f2300dfdab00ed180d9774a5d6bfeb0288de13e2da13fa778a130d38f535fd994724f9ba39d9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cb15110625fa3497ee7d8d1503fdee205c497b682934cc41e694b75e0c78ba084eee8e59e5955d2c92ffc7c6777d392b3ab3ffd98ac5e3c2330146db19b3907"} 01:51:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:51:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:51:32 INFO - Contents: 01:51:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17ee58de68a028f8fecae44b025375a85c8e06201f354fff6aab2f334feb63055a082bb11c0319aa20313b638c6831300d3671e330b1fd47c43b2edf5ff7bb5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e3754e8dba32ee02030c103110e3893a485bbb4eaf1b06ff4f2300dfdab00ed180d9774a5d6bfeb0288de13e2da13fa778a130d38f535fd994724f9ba39d9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cb15110625fa3497ee7d8d1503fdee205c497b682934cc41e694b75e0c78ba084eee8e59e5955d2c92ffc7c6777d392b3ab3ffd98ac5e3c2330146db19b3907"} 01:51:32 INFO - Running post-run listener: copy_logs_to_upload_dir 01:51:32 INFO - Copying logs to upload dir... 01:51:32 INFO - mkdir: /builds/slave/test/build/upload/logs 01:51:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.898612 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-05 01:51:32.044411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 01:51:32.047929) ========= 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=3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17ee58de68a028f8fecae44b025375a85c8e06201f354fff6aab2f334feb63055a082bb11c0319aa20313b638c6831300d3671e330b1fd47c43b2edf5ff7bb5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e3754e8dba32ee02030c103110e3893a485bbb4eaf1b06ff4f2300dfdab00ed180d9774a5d6bfeb0288de13e2da13fa778a130d38f535fd994724f9ba39d9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cb15110625fa3497ee7d8d1503fdee205c497b682934cc41e694b75e0c78ba084eee8e59e5955d2c92ffc7c6777d392b3ab3ffd98ac5e3c2330146db19b3907"} build_url:https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011783 build_url: 'https://queue.taskcluster.net/v1/task/V9XJU-lwSC2AhHub97iHqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17ee58de68a028f8fecae44b025375a85c8e06201f354fff6aab2f334feb63055a082bb11c0319aa20313b638c6831300d3671e330b1fd47c43b2edf5ff7bb5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e3754e8dba32ee02030c103110e3893a485bbb4eaf1b06ff4f2300dfdab00ed180d9774a5d6bfeb0288de13e2da13fa778a130d38f535fd994724f9ba39d9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cb15110625fa3497ee7d8d1503fdee205c497b682934cc41e694b75e0c78ba084eee8e59e5955d2c92ffc7c6777d392b3ab3ffd98ac5e3c2330146db19b3907"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 01:51:32.076563) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 01:51:32.077357) ========= 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=3836458cccd887f2d2de3cf1000001de-1483606759.4925-564661940 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-01-05 01:51:32.157992) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 01:51:32.158364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 01:51:32.158738) ========= ========= Total master_lag: 1.02 =========