builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1480554633.04 results: success (0) buildid: 20161130141744 builduid: 15d4596afa324fb8bdbd79dbdd1c81cf revision: 3fa3896980f6726c3897ce1645a839996d5d5e8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:33.040888) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:33.041382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:33.041666) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:33.053311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:33.053609) ========= 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=41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-30 17:10:33-- 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% 24.4M=0s 2016-11-30 17:10:33 (24.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:33.164657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:33.165028) ========= 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=41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017499 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:33.214900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 17:10:33.215294) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3fa3896980f6726c3897ce1645a839996d5d5e8b --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 3fa3896980f6726c3897ce1645a839996d5d5e8b --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=41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-30 17:10:33,534 truncating revision to first 12 chars 2016-11-30 17:10:33,534 Setting DEBUG logging. 2016-11-30 17:10:33,534 attempt 1/10 2016-11-30 17:10:33,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3fa3896980f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 17:10:34,426 unpacking tar archive at: mozilla-aurora-3fa3896980f6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.195113 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 17:10:34.424278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:34.424651) ========= script_repo_revision: 3fa3896980f6726c3897ce1645a839996d5d5e8b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:34.425098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:34.425427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 17:10:34.435316) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-30 17:10:34.435723) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:10:34 INFO - MultiFileLogger online at 20161130 17:10:34 in /builds/slave/test 17:10:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:10:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:10:34 INFO - {'append_to_log': False, 17:10:34 INFO - 'base_work_dir': '/builds/slave/test', 17:10:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:10:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:10:34 INFO - 'branch': 'Mozilla-Aurora', 17:10:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:10:34 INFO - 'config_files': ('talos/linux_config.py',), 17:10:34 INFO - 'default_actions': ('clobber', 17:10:34 INFO - 'read-buildbot-config', 17:10:34 INFO - 'download-and-extract', 17:10:34 INFO - 'populate-webroot', 17:10:34 INFO - 'create-virtualenv', 17:10:34 INFO - 'install', 17:10:34 INFO - 'run-tests'), 17:10:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:10:34 INFO - 'download_minidump_stackwalk': True, 17:10:34 INFO - 'download_symbols': 'ondemand', 17:10:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:10:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:10:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:10:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:10:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:10:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:10:34 INFO - 'installer_path': 'installer.exe', 17:10:34 INFO - 'log_level': 'info', 17:10:34 INFO - 'log_name': 'talos', 17:10:34 INFO - 'log_to_console': True, 17:10:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:10:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:10:34 INFO - 'opt_config_files': (), 17:10:34 INFO - 'pip_index': False, 17:10:34 INFO - 'sps_profile': False, 17:10:34 INFO - 'sps_profile_interval': 0, 17:10:34 INFO - 'suite': 'dromaeojs-e10s', 17:10:34 INFO - 'system_bits': '32', 17:10:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:10:34 INFO - 'title': 'talos-linux64-ix-024', 17:10:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:10:34 INFO - 'use_talos_json': True, 17:10:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:10:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:10:34 INFO - 'work_dir': 'build'} 17:10:34 INFO - [mozharness: 2016-12-01 01:10:34.856893Z] Running clobber step. 17:10:34 INFO - Running pre-action listener: _resource_record_pre_action 17:10:34 INFO - Running main action method: clobber 17:10:34 INFO - rmtree: /builds/slave/test/build 17:10:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:10:35 INFO - Running post-action listener: _resource_record_post_action 17:10:35 INFO - [mozharness: 2016-12-01 01:10:35.941971Z] Finished clobber step (success) 17:10:35 INFO - [mozharness: 2016-12-01 01:10:35.942071Z] Running read-buildbot-config step. 17:10:35 INFO - Running pre-action listener: _resource_record_pre_action 17:10:35 INFO - Running main action method: read_buildbot_config 17:10:35 INFO - Using buildbot properties: 17:10:35 INFO - { 17:10:35 INFO - "project": "", 17:10:35 INFO - "product": "firefox", 17:10:35 INFO - "script_repo_revision": "production", 17:10:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 17:10:35 INFO - "repository": "", 17:10:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 17:10:35 INFO - "buildid": "20161130141744", 17:10:35 INFO - "pgo_build": "True", 17:10:35 INFO - "basedir": "/builds/slave/test", 17:10:35 INFO - "buildnumber": 683, 17:10:35 INFO - "slavename": "talos-linux64-ix-024", 17:10:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:10:35 INFO - "platform": "ubuntu64_hw", 17:10:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:10:35 INFO - "branch": "mozilla-aurora", 17:10:35 INFO - "repo_path": "releases/mozilla-aurora", 17:10:35 INFO - "revision": "3fa3896980f6726c3897ce1645a839996d5d5e8b", 17:10:35 INFO - "stage_platform": "linux64-pgo", 17:10:35 INFO - "builduid": "15d4596afa324fb8bdbd79dbdd1c81cf", 17:10:35 INFO - "slavebuilddir": "test" 17:10:35 INFO - } 17:10:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 17:10:35 INFO - Running post-action listener: _resource_record_post_action 17:10:35 INFO - [mozharness: 2016-12-01 01:10:35.944502Z] Finished read-buildbot-config step (success) 17:10:35 INFO - [mozharness: 2016-12-01 01:10:35.944590Z] Running download-and-extract step. 17:10:35 INFO - Running pre-action listener: _resource_record_pre_action 17:10:35 INFO - Running main action method: download_and_extract 17:10:35 INFO - mkdir: /builds/slave/test/build/tests 17:10:35 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')]} 17:10:35 INFO - trying https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 17:10:35 INFO - Downloading https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/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 17:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/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 17:10:36 INFO - Downloaded 1361 bytes. 17:10:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 17:10:36 INFO - Using the following test package requirements: 17:10:36 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 17:10:36 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:10:36 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:10:36 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:36 INFO - u'jsshell-linux-x86_64.zip'], 17:10:36 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:10:36 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 17:10:36 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:10:36 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:10:36 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:10:36 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:10:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:10:36 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:10:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 17:10:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:36 INFO - Fetch https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:10:37 INFO - Http code: 200 17:10:37 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 17:10:37 INFO - x-amz-cf-id: LuvngnOL_hr4bywuUJexGV2-sBLGpqNZnGyBrJbYffrDK41gMAvftQ== 17:10:37 INFO - x-amz-version-id: pp0km.p0rkEbTsvrIdzm5t0WoZdNYatp 17:10:37 INFO - Expected file size: 21957919 17:10:37 INFO - Obtained file size: 21957919 17:10:41 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 17:10:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 17:10:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:41 INFO - Fetch https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:10:41 INFO - Http code: 200 17:10:41 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 17:10:41 INFO - x-amz-cf-id: TToq7OANCRa7Ky2Bpf8_SOa6jbM0d5_YSWbyHOOZ9jjNAhOeffVM4w== 17:10:41 INFO - x-amz-version-id: pp0km.p0rkEbTsvrIdzm5t0WoZdNYatp 17:10:42 INFO - Expected file size: 21957919 17:10:42 INFO - Obtained file size: 21957919 17:10:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 17:10:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:10:46 INFO - Fetch https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 17:10:47 INFO - Http code: 200 17:10:47 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 17:10:47 INFO - x-amz-cf-id: Rhv3AoTfLnm3ZCkxzpSnMy3tllV1AjvZl61BWzeKXyrawn85vLjd1g== 17:10:47 INFO - x-amz-version-id: 9brzMc.LcacZuNLdt.8gLEyKNouStq3V 17:10:47 INFO - Expected file size: 14409038 17:10:47 INFO - Obtained file size: 14409038 17:10:47 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')]} 17:10:47 INFO - trying https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 17:10:47 INFO - Downloading https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/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 17:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/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 17:10:48 INFO - Downloaded 63994784 bytes. 17:10:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 17:10:48 INFO - mkdir: /builds/slave/test/properties 17:10:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:10:48 INFO - Writing to file /builds/slave/test/properties/build_url 17:10:48 INFO - Contents: 17:10:48 INFO - build_url:https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 17:10:49 INFO - Running post-action listener: _resource_record_post_action 17:10:49 INFO - Running post-action listener: set_extra_try_arguments 17:10:49 INFO - [mozharness: 2016-12-01 01:10:49.478923Z] Finished download-and-extract step (success) 17:10:49 INFO - [mozharness: 2016-12-01 01:10:49.479150Z] Running populate-webroot step. 17:10:49 INFO - Running pre-action listener: _resource_record_pre_action 17:10:49 INFO - Running main action method: populate_webroot 17:10:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:10:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:10:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:10:49 INFO - '--tppagecycles', 17:10:49 INFO - '7'], 17:10:49 INFO - 'tests': ['tsvgm']}}, 17:10:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:10:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:10:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:10:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:10:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:49 INFO - 'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:49 INFO - 'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['damp', 'tps']}, 17:10:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:49 INFO - 'tests': ['damp', 'tps']}, 17:10:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['dromaeo_dom']}, 17:10:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:10:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['basic_compositor_video']}, 17:10:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:10:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['a11yr', 17:10:49 INFO - 'ts_paint', 17:10:49 INFO - 'tpaint', 17:10:49 INFO - 'sessionrestore', 17:10:49 INFO - 'sessionrestore_no_auto_restore', 17:10:49 INFO - 'tabpaint']}, 17:10:49 INFO - 'other-e10s': {'tests': ['a11yr', 17:10:49 INFO - 'ts_paint', 17:10:49 INFO - 'tpaint', 17:10:49 INFO - 'sessionrestore', 17:10:49 INFO - 'sessionrestore_no_auto_restore', 17:10:49 INFO - 'tabpaint']}, 17:10:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:10:49 INFO - 'ts_paint', 17:10:49 INFO - 'tpaint', 17:10:49 INFO - 'sessionrestore', 17:10:49 INFO - 'sessionrestore_no_auto_restore', 17:10:49 INFO - 'tabpaint']}, 17:10:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:10:49 INFO - 'ts_paint', 17:10:49 INFO - 'tpaint', 17:10:49 INFO - 'sessionrestore', 17:10:49 INFO - 'sessionrestore_no_auto_restore', 17:10:49 INFO - 'tabpaint']}, 17:10:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['a11yr', 17:10:49 INFO - 'ts_paint', 17:10:49 INFO - 'tpaint', 17:10:49 INFO - 'sessionrestore', 17:10:49 INFO - 'sessionrestore_no_auto_restore', 17:10:49 INFO - 'tabpaint']}, 17:10:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['a11yr', 17:10:49 INFO - 'ts_paint', 17:10:49 INFO - 'tpaint', 17:10:49 INFO - 'sessionrestore', 17:10:49 INFO - 'sessionrestore_no_auto_restore', 17:10:49 INFO - 'tabpaint']}, 17:10:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['tsvgx', 17:10:49 INFO - 'tsvgr_opacity', 17:10:49 INFO - 'tart', 17:10:49 INFO - 'tscrollx', 17:10:49 INFO - 'cart']}, 17:10:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:10:49 INFO - 'tsvgr_opacity', 17:10:49 INFO - 'tart', 17:10:49 INFO - 'tscrollx', 17:10:49 INFO - 'cart']}, 17:10:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:49 INFO - 'talos_options': ['--disable-e10s'], 17:10:49 INFO - 'tests': ['tp5o']}, 17:10:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:49 INFO - 'tests': ['tp5o']}, 17:10:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:49 INFO - 'talos_options': ['--disable-e10s', 17:10:49 INFO - '--xperf_path', 17:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:49 INFO - 'tests': ['tp5n']}, 17:10:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:49 INFO - 'talos_options': ['--xperf_path', 17:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:49 INFO - 'tests': ['tp5n']}}, 17:10:49 INFO - 'talos.zip': {'path': '', 17:10:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:10:49 INFO - Running post-action listener: _resource_record_post_action 17:10:49 INFO - [mozharness: 2016-12-01 01:10:49.501563Z] Finished populate-webroot step (success) 17:10:49 INFO - [mozharness: 2016-12-01 01:10:49.501667Z] Running create-virtualenv step. 17:10:49 INFO - Running pre-action listener: _resource_record_pre_action 17:10:49 INFO - Running main action method: create_virtualenv 17:10:49 INFO - Creating virtualenv /builds/slave/test/build/venv 17:10:49 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 17:10:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:10:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:10:49 INFO - Using real prefix '/usr' 17:10:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:10:50 INFO - Installing distribute.............................................................................................................................................................................................done. 17:10:52 INFO - Installing pip.................done. 17:10:52 INFO - Return code: 0 17:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:10:52 INFO - Reading from file tmpfile_stdout 17:10:52 INFO - Output received: 17:10:52 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) 17:10:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:10:52 INFO - Using env: {'DISPLAY': ':0', 17:10:52 INFO - 'HOME': '/home/cltbld', 17:10:52 INFO - 'LANG': 'en_US.UTF-8', 17:10:52 INFO - 'LANGUAGE': 'en_US:en', 17:10:52 INFO - 'LOGNAME': 'cltbld', 17:10:52 INFO - 'MAIL': '/var/mail/cltbld', 17:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:52 INFO - 'MOZ_NO_REMOTE': '1', 17:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:52 INFO - 'NO_EM_RESTART': '1', 17:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:52 INFO - 'PWD': '/builds/slave/test', 17:10:52 INFO - 'SHELL': '/bin/bash', 17:10:52 INFO - 'SHLVL': '1', 17:10:52 INFO - 'TERM': 'linux', 17:10:52 INFO - 'TMOUT': '86400', 17:10:52 INFO - 'USER': 'cltbld', 17:10:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:52 INFO - '_': '/tools/buildbot/bin/python'} 17:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:52 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 17:10:52 INFO - Cleaning up... 17:10:52 INFO - Return code: 0 17:10:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:10:52 INFO - Using env: {'DISPLAY': ':0', 17:10:52 INFO - 'HOME': '/home/cltbld', 17:10:52 INFO - 'LANG': 'en_US.UTF-8', 17:10:52 INFO - 'LANGUAGE': 'en_US:en', 17:10:52 INFO - 'LOGNAME': 'cltbld', 17:10:52 INFO - 'MAIL': '/var/mail/cltbld', 17:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:52 INFO - 'MOZ_NO_REMOTE': '1', 17:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:52 INFO - 'NO_EM_RESTART': '1', 17:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:52 INFO - 'PWD': '/builds/slave/test', 17:10:52 INFO - 'SHELL': '/bin/bash', 17:10:52 INFO - 'SHLVL': '1', 17:10:52 INFO - 'TERM': 'linux', 17:10:52 INFO - 'TMOUT': '86400', 17:10:52 INFO - 'USER': 'cltbld', 17:10:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:52 INFO - '_': '/tools/buildbot/bin/python'} 17:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:52 INFO - Downloading/unpacking psutil>=3.1.1 17:10:52 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 17:10:52 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 17:10:52 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 17:10:52 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 17:10:52 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 17:10:52 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 17:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:54 INFO - Installing collected packages: psutil 17:10:54 INFO - Running setup.py install for psutil 17:10:54 INFO - building 'psutil._psutil_linux' extension 17:10:54 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 17:10:55 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 17:10:55 INFO - building 'psutil._psutil_posix' extension 17:10:55 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 17:10:55 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 17:10:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:55 INFO - Successfully installed psutil 17:10:55 INFO - Cleaning up... 17:10:55 INFO - Return code: 0 17:10:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:10:55 INFO - Using env: {'DISPLAY': ':0', 17:10:55 INFO - 'HOME': '/home/cltbld', 17:10:55 INFO - 'LANG': 'en_US.UTF-8', 17:10:55 INFO - 'LANGUAGE': 'en_US:en', 17:10:55 INFO - 'LOGNAME': 'cltbld', 17:10:55 INFO - 'MAIL': '/var/mail/cltbld', 17:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:55 INFO - 'MOZ_NO_REMOTE': '1', 17:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:55 INFO - 'NO_EM_RESTART': '1', 17:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:55 INFO - 'PWD': '/builds/slave/test', 17:10:55 INFO - 'SHELL': '/bin/bash', 17:10:55 INFO - 'SHLVL': '1', 17:10:55 INFO - 'TERM': 'linux', 17:10:55 INFO - 'TMOUT': '86400', 17:10:55 INFO - 'USER': 'cltbld', 17:10:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:55 INFO - '_': '/tools/buildbot/bin/python'} 17:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:10:57 INFO - Installing collected packages: mozsystemmonitor 17:10:57 INFO - Running setup.py install for mozsystemmonitor 17:10:57 INFO - Successfully installed mozsystemmonitor 17:10:57 INFO - Cleaning up... 17:10:57 INFO - Return code: 0 17:10:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:10:57 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')]} 17:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:57 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')]} 17:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:57 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 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:10:57 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 17:10:57 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 17:10:57 INFO - Using env: {'DISPLAY': ':0', 17:10:57 INFO - 'HOME': '/home/cltbld', 17:10:57 INFO - 'LANG': 'en_US.UTF-8', 17:10:57 INFO - 'LANGUAGE': 'en_US:en', 17:10:57 INFO - 'LOGNAME': 'cltbld', 17:10:57 INFO - 'MAIL': '/var/mail/cltbld', 17:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:57 INFO - 'MOZ_NO_REMOTE': '1', 17:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:57 INFO - 'NO_EM_RESTART': '1', 17:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:57 INFO - 'PWD': '/builds/slave/test', 17:10:57 INFO - 'SHELL': '/bin/bash', 17:10:57 INFO - 'SHLVL': '1', 17:10:57 INFO - 'TERM': 'linux', 17:10:57 INFO - 'TMOUT': '86400', 17:10:57 INFO - 'USER': 'cltbld', 17:10:57 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:57 INFO - '_': '/tools/buildbot/bin/python'} 17:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:58 INFO - Downloading/unpacking jsonschema==2.5.1 17:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:10:59 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 17:10:59 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 17:10:59 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 17:10:59 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 17:10:59 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 17:10:59 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 17:11:00 INFO - Downloading functools32-3.2.3-2.tar.gz 17:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:11:00 INFO - warning: no files found matching '*.txt' 17:11:00 INFO - no previously-included directories found matching 'build' 17:11:00 INFO - no previously-included directories found matching 'dist' 17:11:00 INFO - no previously-included directories found matching '.git*' 17:11:00 INFO - Installing collected packages: jsonschema, functools32 17:11:00 INFO - Running setup.py install for functools32 17:11:00 INFO - warning: no files found matching '*.txt' 17:11:00 INFO - no previously-included directories found matching 'build' 17:11:00 INFO - no previously-included directories found matching 'dist' 17:11:00 INFO - no previously-included directories found matching '.git*' 17:11:00 INFO - Successfully installed jsonschema functools32 17:11:00 INFO - Cleaning up... 17:11:00 INFO - Return code: 0 17:11:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:00 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 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:11:00 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 17:11:00 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 17:11:00 INFO - Using env: {'DISPLAY': ':0', 17:11:00 INFO - 'HOME': '/home/cltbld', 17:11:00 INFO - 'LANG': 'en_US.UTF-8', 17:11:00 INFO - 'LANGUAGE': 'en_US:en', 17:11:00 INFO - 'LOGNAME': 'cltbld', 17:11:00 INFO - 'MAIL': '/var/mail/cltbld', 17:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:00 INFO - 'MOZ_NO_REMOTE': '1', 17:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:00 INFO - 'NO_EM_RESTART': '1', 17:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:00 INFO - 'PWD': '/builds/slave/test', 17:11:00 INFO - 'SHELL': '/bin/bash', 17:11:00 INFO - 'SHLVL': '1', 17:11:00 INFO - 'TERM': 'linux', 17:11:00 INFO - 'TMOUT': '86400', 17:11:00 INFO - 'USER': 'cltbld', 17:11:00 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:00 INFO - '_': '/tools/buildbot/bin/python'} 17:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:11:00 INFO - Cleaning up... 17:11:00 INFO - Return code: 0 17:11:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:00 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 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:11:00 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 17:11:00 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 17:11:00 INFO - Using env: {'DISPLAY': ':0', 17:11:00 INFO - 'HOME': '/home/cltbld', 17:11:00 INFO - 'LANG': 'en_US.UTF-8', 17:11:00 INFO - 'LANGUAGE': 'en_US:en', 17:11:00 INFO - 'LOGNAME': 'cltbld', 17:11:00 INFO - 'MAIL': '/var/mail/cltbld', 17:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:00 INFO - 'MOZ_NO_REMOTE': '1', 17:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:00 INFO - 'NO_EM_RESTART': '1', 17:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:00 INFO - 'PWD': '/builds/slave/test', 17:11:00 INFO - 'SHELL': '/bin/bash', 17:11:00 INFO - 'SHLVL': '1', 17:11:00 INFO - 'TERM': 'linux', 17:11:00 INFO - 'TMOUT': '86400', 17:11:00 INFO - 'USER': 'cltbld', 17:11:00 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:00 INFO - '_': '/tools/buildbot/bin/python'} 17:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:02 INFO - Downloading blobuploader-1.2.4.tar.gz 17:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:11:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:11:02 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 17:11:02 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 17:11:02 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 17:11:02 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 17:11:02 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 17:11:02 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 17:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:11:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:03 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 17:11:03 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 17:11:03 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 17:11:03 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 17:11:03 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 17:11:03 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 17:11:03 INFO - Downloading docopt-0.6.1.tar.gz 17:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:11:03 INFO - Installing collected packages: blobuploader, requests, docopt 17:11:03 INFO - Running setup.py install for blobuploader 17:11:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:11:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:11:03 INFO - Running setup.py install for requests 17:11:04 INFO - Running setup.py install for docopt 17:11:04 INFO - Successfully installed blobuploader requests docopt 17:11:04 INFO - Cleaning up... 17:11:04 INFO - Return code: 0 17:11:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:04 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 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:11:04 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 17:11:04 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 17:11:04 INFO - Using env: {'DISPLAY': ':0', 17:11:04 INFO - 'HOME': '/home/cltbld', 17:11:04 INFO - 'LANG': 'en_US.UTF-8', 17:11:04 INFO - 'LANGUAGE': 'en_US:en', 17:11:04 INFO - 'LOGNAME': 'cltbld', 17:11:04 INFO - 'MAIL': '/var/mail/cltbld', 17:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:04 INFO - 'MOZ_NO_REMOTE': '1', 17:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:04 INFO - 'NO_EM_RESTART': '1', 17:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:04 INFO - 'PWD': '/builds/slave/test', 17:11:04 INFO - 'SHELL': '/bin/bash', 17:11:04 INFO - 'SHLVL': '1', 17:11:04 INFO - 'TERM': 'linux', 17:11:04 INFO - 'TMOUT': '86400', 17:11:04 INFO - 'USER': 'cltbld', 17:11:04 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:04 INFO - '_': '/tools/buildbot/bin/python'} 17:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:04 INFO - Running setup.py (path:/tmp/pip-hzKQ3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:04 INFO - Running setup.py (path:/tmp/pip-0NpKpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:04 INFO - Running setup.py (path:/tmp/pip-5VtcDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:04 INFO - Running setup.py (path:/tmp/pip-IrziKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:04 INFO - Running setup.py (path:/tmp/pip-Ur59wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:04 INFO - Running setup.py (path:/tmp/pip-gNQjeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:04 INFO - Running setup.py (path:/tmp/pip-HDwcWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:05 INFO - Running setup.py (path:/tmp/pip-OZ2MY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:05 INFO - Running setup.py (path:/tmp/pip-l4PQSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:05 INFO - Running setup.py (path:/tmp/pip-UHbKYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:05 INFO - Running setup.py (path:/tmp/pip-CUwnIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:05 INFO - Running setup.py (path:/tmp/pip-9Ws2e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:05 INFO - Running setup.py (path:/tmp/pip-cIC3ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:05 INFO - Running setup.py (path:/tmp/pip-UZqysD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:05 INFO - Running setup.py (path:/tmp/pip-ItMEOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:05 INFO - Running setup.py (path:/tmp/pip-x5ie42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:05 INFO - Running setup.py (path:/tmp/pip-0ah7Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:11:05 INFO - Running setup.py install for manifestparser 17:11:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Running setup.py install for mozcrash 17:11:05 INFO - Running setup.py install for mozdebug 17:11:06 INFO - Running setup.py install for mozdevice 17:11:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Running setup.py install for mozfile 17:11:06 INFO - Running setup.py install for mozhttpd 17:11:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Running setup.py install for mozinfo 17:11:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Running setup.py install for mozInstall 17:11:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Running setup.py install for mozleak 17:11:06 INFO - Running setup.py install for mozlog 17:11:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Running setup.py install for moznetwork 17:11:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Running setup.py install for mozprocess 17:11:07 INFO - Running setup.py install for mozprofile 17:11:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:11:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:11:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:11:07 INFO - Running setup.py install for mozrunner 17:11:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:11:07 INFO - Running setup.py install for mozscreenshot 17:11:07 INFO - Running setup.py install for moztest 17:11:07 INFO - Running setup.py install for mozversion 17:11:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:11:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:11:07 INFO - Cleaning up... 17:11:07 INFO - Return code: 0 17:11:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:07 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 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:11:07 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 17:11:07 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 17:11:07 INFO - Using env: {'DISPLAY': ':0', 17:11:07 INFO - 'HOME': '/home/cltbld', 17:11:07 INFO - 'LANG': 'en_US.UTF-8', 17:11:07 INFO - 'LANGUAGE': 'en_US:en', 17:11:07 INFO - 'LOGNAME': 'cltbld', 17:11:07 INFO - 'MAIL': '/var/mail/cltbld', 17:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:07 INFO - 'MOZ_NO_REMOTE': '1', 17:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:07 INFO - 'NO_EM_RESTART': '1', 17:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:07 INFO - 'PWD': '/builds/slave/test', 17:11:07 INFO - 'SHELL': '/bin/bash', 17:11:07 INFO - 'SHLVL': '1', 17:11:07 INFO - 'TERM': 'linux', 17:11:07 INFO - 'TMOUT': '86400', 17:11:07 INFO - 'USER': 'cltbld', 17:11:07 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:07 INFO - '_': '/tools/buildbot/bin/python'} 17:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:07 INFO - Running setup.py (path:/tmp/pip-F2Az05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:07 INFO - Running setup.py (path:/tmp/pip-GpAAYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:07 INFO - Running setup.py (path:/tmp/pip-1J4u2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:08 INFO - Running setup.py (path:/tmp/pip-Jrf97y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:08 INFO - Running setup.py (path:/tmp/pip-h18cVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:08 INFO - Running setup.py (path:/tmp/pip-ZDUj87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:08 INFO - Running setup.py (path:/tmp/pip-TzV2OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:08 INFO - Running setup.py (path:/tmp/pip-Xuvecl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:08 INFO - Running setup.py (path:/tmp/pip-cCHRP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:08 INFO - Running setup.py (path:/tmp/pip-upuSaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:08 INFO - Running setup.py (path:/tmp/pip-cWI9Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:08 INFO - Running setup.py (path:/tmp/pip-sWLhvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:08 INFO - Running setup.py (path:/tmp/pip-ewrKsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:08 INFO - Running setup.py (path:/tmp/pip-_7meAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:08 INFO - Running setup.py (path:/tmp/pip-3WMWIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:08 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)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:08 INFO - Running setup.py (path:/tmp/pip-8yLkGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:08 INFO - Running setup.py (path:/tmp/pip-3n69Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:09 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)) 17:11:09 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)) 17:11:09 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)) 17:11:09 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)) 17:11:09 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)) 17:11:09 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)) 17:11:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:11 INFO - Downloading blessings-1.6.tar.gz 17:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:11:11 INFO - Installing collected packages: blessings 17:11:11 INFO - Running setup.py install for blessings 17:11:11 INFO - Successfully installed blessings 17:11:11 INFO - Cleaning up... 17:11:11 INFO - Return code: 0 17:11:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:11 INFO - Reading from file tmpfile_stdout 17:11:11 INFO - Current package versions: 17:11:11 INFO - argparse == 1.2.1 17:11:11 INFO - blessings == 1.6 17:11:11 INFO - blobuploader == 1.2.4 17:11:11 INFO - docopt == 0.6.1 17:11:11 INFO - functools32 == 3.2.3-2 17:11:11 INFO - jsonschema == 2.5.1 17:11:11 INFO - manifestparser == 1.1 17:11:11 INFO - mozInstall == 1.12 17:11:11 INFO - mozcrash == 1.0 17:11:11 INFO - mozdebug == 0.1 17:11:11 INFO - mozdevice == 0.48 17:11:11 INFO - mozfile == 1.2 17:11:11 INFO - mozhttpd == 0.7 17:11:11 INFO - mozinfo == 0.9 17:11:11 INFO - mozleak == 0.1 17:11:11 INFO - mozlog == 3.4 17:11:11 INFO - moznetwork == 0.27 17:11:11 INFO - mozprocess == 0.23 17:11:11 INFO - mozprofile == 0.28 17:11:11 INFO - mozrunner == 6.13 17:11:11 INFO - mozscreenshot == 0.1 17:11:11 INFO - mozsystemmonitor == 0.3 17:11:11 INFO - moztest == 0.7 17:11:11 INFO - mozversion == 1.4 17:11:11 INFO - psutil == 3.1.1 17:11:11 INFO - requests == 1.2.3 17:11:11 INFO - wsgiref == 0.1.2 17:11:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:11 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')]} 17:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:11 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')]} 17:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:11 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 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:11:11 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 17:11:11 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 17:11:11 INFO - Using env: {'DISPLAY': ':0', 17:11:11 INFO - 'HOME': '/home/cltbld', 17:11:11 INFO - 'LANG': 'en_US.UTF-8', 17:11:11 INFO - 'LANGUAGE': 'en_US:en', 17:11:11 INFO - 'LOGNAME': 'cltbld', 17:11:11 INFO - 'MAIL': '/var/mail/cltbld', 17:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:11 INFO - 'MOZ_NO_REMOTE': '1', 17:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:11 INFO - 'NO_EM_RESTART': '1', 17:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:11 INFO - 'PWD': '/builds/slave/test', 17:11:11 INFO - 'SHELL': '/bin/bash', 17:11:11 INFO - 'SHLVL': '1', 17:11:11 INFO - 'TERM': 'linux', 17:11:11 INFO - 'TMOUT': '86400', 17:11:11 INFO - 'USER': 'cltbld', 17:11:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:11 INFO - '_': '/tools/buildbot/bin/python'} 17:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:11 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)) 17:11:11 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)) 17:11:11 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)) 17:11:11 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)) 17:11:11 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)) 17:11:11 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)) 17:11:11 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)) 17:11:11 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)) 17:11:11 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)) 17:11:11 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)) 17:11:11 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)) 17:11:11 INFO - Cleaning up... 17:11:11 INFO - Return code: 0 17:11:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:11:11 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')]} 17:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:11 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')]} 17:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:11 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 0x7fac882fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, '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': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', '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 17:11:11 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 17:11:11 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 17:11:11 INFO - Using env: {'DISPLAY': ':0', 17:11:11 INFO - 'HOME': '/home/cltbld', 17:11:11 INFO - 'LANG': 'en_US.UTF-8', 17:11:11 INFO - 'LANGUAGE': 'en_US:en', 17:11:11 INFO - 'LOGNAME': 'cltbld', 17:11:11 INFO - 'MAIL': '/var/mail/cltbld', 17:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:11 INFO - 'MOZ_NO_REMOTE': '1', 17:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:11 INFO - 'NO_EM_RESTART': '1', 17:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:11 INFO - 'PWD': '/builds/slave/test', 17:11:11 INFO - 'SHELL': '/bin/bash', 17:11:11 INFO - 'SHLVL': '1', 17:11:11 INFO - 'TERM': 'linux', 17:11:11 INFO - 'TMOUT': '86400', 17:11:11 INFO - 'USER': 'cltbld', 17:11:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:11 INFO - '_': '/tools/buildbot/bin/python'} 17:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:11:12 INFO - Cleaning up... 17:11:12 INFO - Return code: 0 17:11:12 INFO - Running post-action listener: _resource_record_post_action 17:11:12 INFO - Running post-action listener: _start_resource_monitoring 17:11:12 INFO - Starting resource monitoring. 17:11:12 INFO - [mozharness: 2016-12-01 01:11:12.214018Z] Finished create-virtualenv step (success) 17:11:12 INFO - [mozharness: 2016-12-01 01:11:12.214486Z] Running install step. 17:11:12 INFO - Running pre-action listener: _resource_record_pre_action 17:11:12 INFO - Running main action method: install 17:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:12 INFO - Reading from file tmpfile_stdout 17:11:12 INFO - Detecting whether we're running mozinstall >=1.0... 17:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:11:12 INFO - Reading from file tmpfile_stdout 17:11:12 INFO - Output received: 17:11:12 INFO - Usage: mozinstall [options] installer 17:11:12 INFO - Options: 17:11:12 INFO - -h, --help show this help message and exit 17:11:12 INFO - -d DEST, --destination=DEST 17:11:12 INFO - Directory to install application into. [default: 17:11:12 INFO - "/builds/slave/test"] 17:11:12 INFO - --app=APP Application being installed. [default: firefox] 17:11:12 INFO - mkdir: /builds/slave/test/build/application 17:11:12 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'] 17:11:12 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 17:11:28 INFO - Reading from file tmpfile_stdout 17:11:28 INFO - Output received: 17:11:28 INFO - /builds/slave/test/build/application/firefox/firefox 17:11:28 INFO - Running post-action listener: _resource_record_post_action 17:11:28 INFO - [mozharness: 2016-12-01 01:11:28.430302Z] Finished install step (success) 17:11:28 INFO - [mozharness: 2016-12-01 01:11:28.430546Z] Running run-tests step. 17:11:28 INFO - Running pre-action listener: _resource_record_pre_action 17:11:28 INFO - Running main action method: run_tests 17:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:11:28 INFO - Python 2.7.3 17:11:28 INFO - Return code: 0 17:11:28 INFO - grabbing minidump binary from tooltool 17:11:28 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')]} 17:11:28 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 0x269df60>, '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 0x269ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:11:28 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 17:11:28 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 17:11:28 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 17:11:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:11:28 INFO - Return code: 0 17:11:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:11:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:11:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:11:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:11:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:11:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:11:28 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:11:28 INFO - Using env: {'DISPLAY': ':0', 17:11:28 INFO - 'HOME': '/home/cltbld', 17:11:28 INFO - 'LANG': 'en_US.UTF-8', 17:11:28 INFO - 'LANGUAGE': 'en_US:en', 17:11:28 INFO - 'LOGNAME': 'cltbld', 17:11:28 INFO - 'MAIL': '/var/mail/cltbld', 17:11:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:11:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:28 INFO - 'MOZ_NO_REMOTE': '1', 17:11:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:28 INFO - 'NO_EM_RESTART': '1', 17:11:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:28 INFO - 'PWD': '/builds/slave/test', 17:11:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:11:28 INFO - 'SHELL': '/bin/bash', 17:11:28 INFO - 'SHLVL': '1', 17:11:28 INFO - 'TERM': 'linux', 17:11:28 INFO - 'TMOUT': '86400', 17:11:28 INFO - 'USER': 'cltbld', 17:11:28 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145', 17:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:28 INFO - '_': '/tools/buildbot/bin/python'} 17:11:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:11:28 INFO - mozversion application_buildid: 20161130141744 17:11:28 INFO - mozversion application_changeset: 3fa3896980f6726c3897ce1645a839996d5d5e8b 17:11:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:11:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:11:28 INFO - mozversion application_name: Firefox 17:11:28 INFO - mozversion application_remotingname: firefox-dev 17:11:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:11:28 INFO - mozversion application_vendor: Mozilla 17:11:28 INFO - mozversion application_version: 52.0a2 17:11:28 INFO - mozversion platform_buildid: 20161130141744 17:11:28 INFO - mozversion platform_changeset: 3fa3896980f6726c3897ce1645a839996d5d5e8b 17:11:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:11:28 INFO - mozversion platform_version: 52.0a2 17:11:28 INFO - using testdate: 1480554688 17:11:28 INFO - actual date: 1480554688 17:11:28 INFO - starting webserver on 'localhost:51024' 17:11:28 INFO - SUITE-START | Running 2 tests 17:11:28 INFO - TEST-START | dromaeo_css 17:11:28 INFO - operating with platform_type : linux_ 17:11:28 INFO - Initialising browser for dromaeo_css test... 17:11:28 INFO - TEST-INFO | started process 13749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpot3ri4/profile http://localhost:51024/getInfo.html) 17:11:33 INFO - PROCESS | 13749 | __metrics Screen width/height:1600/1200 17:11:33 INFO - PROCESS | 13749 | colorDepth:24 17:11:33 INFO - PROCESS | 13749 | Browser inner width/height: 1024/697 17:11:33 INFO - PROCESS | 13749 | __metrics 17:11:33 ERROR - PROCESS | 13749 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 17:11:34 INFO - TEST-INFO | 13749: exit 0 17:11:34 INFO - Browser initialized. 17:11:34 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:34 INFO - TEST-INFO | started process 13881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpot3ri4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:46 INFO - PROCESS | 13881 | RSS: Main: 151642112 17:11:46 INFO - PROCESS | 13881 | 17:12:36 INFO - PROCESS | 13881 | 1480554756123 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:14:46 INFO - PROCESS | 13881 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51024/tests/dromaeo/cssquery-ext.html) 17:14:48 INFO - PROCESS | 13881 | RSS: Main: 155791360 17:14:48 INFO - PROCESS | 13881 | 17:17:50 INFO - PROCESS | 13881 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-ext.html (next: http://localhost:51024/tests/dromaeo/cssquery-jquery.html) 17:17:50 INFO - PROCESS | 13881 | RSS: Main: 153051136 17:17:50 INFO - PROCESS | 13881 | 17:20:52 INFO - PROCESS | 13881 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51024/tests/dromaeo/cssquery-mootools.html) 17:20:53 INFO - PROCESS | 13881 | RSS: Main: 153165824 17:20:53 INFO - PROCESS | 13881 | 17:23:54 INFO - PROCESS | 13881 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51024/tests/dromaeo/cssquery-prototype.html) 17:23:55 INFO - PROCESS | 13881 | RSS: Main: 151584768 17:23:55 INFO - PROCESS | 13881 | 17:26:58 INFO - PROCESS | 13881 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51024/tests/dromaeo/cssquery-yui.html) 17:26:58 INFO - PROCESS | 13881 | RSS: Main: 153821184 17:26:58 INFO - PROCESS | 13881 | 17:30:00 INFO - PROCESS | 13881 | Cycle 1(1): loaded http://localhost:51024/tests/dromaeo/cssquery-yui.html (next: http://localhost:51024/tests/dromaeo/cssquery-dojo.html) 17:30:01 INFO - PROCESS | 13881 | RSS: Main: 155189248 17:30:01 INFO - PROCESS | 13881 | 17:30:01 INFO - PROCESS | 13881 | __start_tp_report 17:30:01 INFO - PROCESS | 13881 | _x_x_mozilla_page_load 17:30:01 INFO - PROCESS | 13881 | _x_x_mozilla_page_load_details 17:30:01 INFO - PROCESS | 13881 | |i|pagename|runs| 17:30:01 INFO - PROCESS | 13881 | |0;dojo.html;3238.753080064175;3256.446404111301;3276.5249038889347;3280.1307653471818;3290.2596915693966;5543.223948647193;5553.972230138844;5570.192322113291;5576.944230557693;5590.049691552435;5615.382307946133;5742.511886489653;5748.885022299552;5758.309002919645;5769.076947688371;5180.637355385115;5216.765245563959;5257.631965762398;5271.2356708277275;5274.314339135907;5279.524842764151;5287.286216360781;5301.575873930076;5303.787848486075;5311.017461769566;5049.823256186034;5050.898982020358;5285.894282114375;5288.735563221842;5319.654222475527;5135.35808023997;5146.691198528081;5147.562457191143;5167.9224811627855;5194.454582268883;5112.386513618352;5128.769205385729;5138.3577052868395;5140.1518749406305;5206.895862082775;5598.44015598441;5620.91568626471;5699.68651724155;5716.628419152742;5749.741261643194;5895.410458954113;5951.49412299955;5974.3428222895445;5993.9700301498215;5994;5984.521238300926;5991.730372133265;6030.879382412371;6037.245344331958;6042.0332746760305;5546.500814926676;5598.440155984369;5622.409646987048;5631.8592035199445;5638.295213098363;6085;6093.756249750049;6143.32423433422;6192.535559833031;6206.627602343874;5918.674472904032;5937.050071988461;5944.762209511658;5947.613405128653;5951.672658003765;5935.881282374415;6033.758649653964;6040.7583696651645;6043.09353596964;6049;5871.4715675589405;5890.4698577128265;5892.528597712173;5971.9701401493585;5976.223090998143;5829.979753543113;5927.496162826208;5931.673757943355;5932.555058370639;5933.110033494924;4559.908801823945;4579.496255411902;4609.2394754865745;4628.722276663411;4646.512116227747;4083.9183216335505;4087.141700242923;4121.29937910556;4137.627613514798;4185.9581404185565;5724.685142317213;5726.169705392695;5742.827715168552;5746.396628353963;5775.364709881909;5857.092150716646;5934.139549765347;5952.4047595241;5968.791092311748;5981.252343457068;5631.352394474606;5646.378898321182;5664.376918538957;5670.092785154438;5744.396838331999;5109.20807274873;5131.076406246912;5142.382914050338;5156.278121063054;5162.741862906914;6183.350748171557;6215.844603884849;6240.53196010292;6260.749570017239;6290.150829638032;5868.677222752619;5883.35283118848;5999.280086389661;6016.939830601813;6024.216851809237;6348.555601107878;6350.4919606432295;6361.522885783677;6366.108744775643;6372.107904893226;5925.111233315038;5937.673427961504;5950.077737950624;6009.819705408845;6017.330469836127;5848.853778655397;5943.049112142036;6009.2188015557695;6118.131909153847;6135.5082808396355;5878.794242201502;5886.558508111994;5887.7056147191615;5903.557233207441;5932.288125424977;5893.469587737124;5911.3201981772645;5916.142159386951;5917.142014407973;5921.111833224878;5675.914861277001;5773.076307790901;5883.411658834254;5886.3525012247765;5888.116782482491;5792.9710351447975;5814.331351894586;5819.79630712923;5832.212651292021;5882.264716910387;5667.886642267049;5710.143478478261;5721.542276617944;5733.283339582552;5733.426657334233 17:30:01 INFO - PROCESS | 13881 | |1;ext.html;588.9705514724266;614.7203022624706;644.1239913717345;660.33966033966;667.5660820466693;44740.552594474044;45598.17607295708;45659.315110273375;48866.51133488673;48895;46701.53298467014;46818;46837.765811170895;47264.291035634495;47419;8767.342449316311;8851.33614978876;8868.157525035143;8918.28653707705;8950.194482496574;8918.598663060178;8928.19646231839;8967.327450441211;8972.46165230085;9016.098390160996;9000.549972501381;9025.548722563846;9058.456492610432;9063.048379920112;9072.773180670503;8938.64245430182;8973.730788076367;9010.54947252638;9025;9030.45817250967;8834.381593288472;8839.46963182211;8872.689455869013;8926.910730892672;8928.776780580538;43505;44186.33720494195;44306.33540496895;44322.778386108184;44327.55672443299;3589.766665166756;3873.1672690371706;4061.2689715851134;4112.835486580533;4370.562943705604;33855.32289354199;33890;34078.659213407795;34252.6574734252;34276.82861585701;4314.95039856069;4333.306670932636;4346.891327716832;4357.477102747659;4440.666949978732;343936;346697;348150;349554;350398;66420;66761.33238667648;66768.6661566689;66855.66572167107;67017.66491167514;68504;68786.312136878;68906.65546672334;69100;69166.65416672884;16681.91659041721;16873.831261687224;16889.493315200565;16891.915540422466;16967.660646786993;14098.295085245696;14120.788188177186;14192.503262385973;14216.715665686628;14284.357203925849;20025.09887055086;20345;20507.897460512602;20602.793972060386;20652.690209646866;7268.45486588508;7474.887876681854;7684.116326622398;7695.268949449794;7790.766277011699;978.500964508106;1054.593981317183;1078.5631819113114;1149.9995004346272;1200.37580458163;32741.672583273863;32837.34325313528;33001.575682629424;34193.31613367719;34416.13959650978;1109.2124591540096;1169.91225658076;1178.876217997098;1184.3959580613778;1241.2924632959127;17061.317547297967;17571.824281757275;17836.3757268495;18292.359767408077;18502.167402466654;527348;527665;531817;533342;533355;61845.69077154585;62366.376336236965;62485;62591.68704156541;62743.6862815683;1430.141914851081;1441.7188648213498;1443.0692203528874;1447.3197597129333;1476.0995792566525;31848.840755796075;33966.49050264298;34368.48447273243;34445;34559.481607776404;55202;55853;56145.71927140338;56349.71825140848;56394.43605564056;448117;449431;450411;451793;453504;30613.387732245676;30773;30861.537076944314;30996.690033100283;31184.22039449032;50760;50878;51650;54881.45118548923;56042.43957560372;42013.57986420097;42769.144617108104;44286.55713442953;45314.093718124794;46581;42670.78664606657;44272.335914960655;44771;45200.77399612981;45520.317195241434;43869.78065109654;44649.55350446454;44721.552784471736;44745.55254447544;46835.53164468312;38366.232675346895;38760.22479550337;38798.61201388063;39329.803350983064;39412.40881386839;30173.849130755083;30254.243643909078;30299;30514.847425762728;30896.84551577228 17:30:01 INFO - PROCESS | 13881 | |2;jquery.html;428.03744829954655;430.1568924907182;438.0887753472776;440.55937085729664;451.73121992414525;18651.1606977686;19460.610787784255;20272.695909561367;20368.287109951154;20389.796102038974;17202.96782193069;19133.808661913376;19584.608307833834;19795;19859.20563177475;5179.507946745062;5406.378266499363;5442.374126975389;5443.646162999412;5446.891062178754;5256.369235691723;5343.572514198874;5377.166539186433;5443.401225865152;5468.343798744137;5413.052715774744;5422.9728851355685;5424.321959755031;5429.0227759003365;5431.864203394927;5369.973150134244;5413.188021796723;5421.21392398102;5508.9724551377385;5773.913391299134;5260;5283.841484755463;5307.442718514539;5312.681239125626;5324.680519168824;22993.195238166583;23459.882700586557;24136;24155.75844241553;24170;2519.7732204101717;2550.298667866333;2631.158029430583;2705.3912869604183;3000.7149320814488;10774.515146818334;11283.887161128365;11504.137189710722;12578.559750408784;15523.689526209413;1993.4717299915535;2009.0758251204463;2028.98985505073;2058.691196320549;2071.8031786980214;81875.59062204651;82069.58965205196;82580.58709706474;83145.99999999939;85926.14073859244;9723.902760972442;10282.691519254435;10390.012948769854;10453;10474.895251047392;13825.963052771083;13846.376913038937;13871.167729936236;13886.09740366873;13935.512257070954;8191.959040204761;8431.620577074047;8467.788305292293;8474.830503390021;8665.610047547876;8650.221480066824;8767.736967890973;8807.987081485582;8883;9040.276777857756;4175.54069052404;4205.747655140702;4296.2696341621995;4305.547917468683;4529.977350113229;2087.6346639338053;2101.109001898273;2133.637281662121;2134.5624147049816;2138.219549864288;927.4713413354323;988.9554970026367;1014.5333146752577;1061.6549621373085;1065.4033741105006;19945.800541994686;20764.896175519025;20839.8958005209;20987.475313117295;21047.57904841925;968.4237878462303;1014.573878970834;1017.2167431078176;1025.646152077532;1031.7214352124884;10668.14654827612;11603.303801771921;11605.6518304451;11653.941730291293;11665.591704290478;156257;505911;506501;523068;530382;90980;92846;94969;96703.51648241855;98762.5061874686;993.7565296502403;998.7353351362041;1008.2841182760176;1021.8365061590258;1023.4626820918928;17423.041732704314;17967.910160449115;18122.365717199835;18150.636987260445;18183.363582275088;43235.35146972735;43735;43986;44916.10167796691;45450;58895.70552147212;59464.70267648807;59683;60013.09980350386;61042.38957610367;8665.740027799176;8713.215810577078;8861.468311901306;8932.330075244512;9052.3210759192;11419.771604568028;13741.725165496435;13746.65633359174;13909.930450347683;14056.226907519775;11782.528698852293;12153.149279550347;12295.385230738248;12326.32205228721;12329.136960413043;11754.706132346417;11912.821307680566;11969.222000570284;11989.40052997364;12263.141580089308;12147.825091233351;12178.269303841444;12224.449899754354;12621.242725436503;12732.490700372251;8196.42625016243;8296.128906464975;8368.24685778283;8373.037100733494;9201.263898888206;10518.421486818299;12458.626241212778;12501.93749031249;12603.74792504163;12852.164609300366 17:30:01 INFO - PROCESS | 13881 | |3;mootools.html;1419.2690764256406;1486.0118021515693;1573.7009968106058;1762.347931265432;1763.4357005758154;7850;8045.034595848491;8220;8703.303735701145;8751.562421878913;8278.710245141421;8592.699255526059;8594.312455003601;8701.216890479856;8752.29981601472;2459.495803360307;2497.9750202497926;2512.0705339024585;2514.710808257046;2518.0809004713333;2469.6665950096776;2554.246497283297;2554.5784945484065;2555.463352695927;2559.539282929072;2424.842385244953;2463.6797216361847;2507.448361360498;2508.9372765680914;2509.636102765107;2410.7227668818136;2429.356220601542;2431.720352159498;2432.8053755699502;2454.0674543673467;2446.412860913386;2460.9261722148362;2471.221565206972;2486.539990101837;2488.962665560018;8736.694215702484;8737.694180703646;8746.037935827055;8768.561571921442;8823.029466758651;5437.945620543823;5601.80393686219;5612.214289999403;5620.803271885465;5623.353314368859;3376.2909788944353;3429.4341433663417;3460.913477163066;3466.6879980801596;3473.930521389583;1123.219362543033;1123.7752449510049;1147.6270212181075;1186.2763714134371;1230.846144231971;11786;11818.881811181864;11868.228565143238;11878.168528203028;11879.34663593502;4543.5910768031035;4584.839530616412;4696.722089786451;4704.364910737075;4856.490068542823;9943.552540135712;9979.800403992025;10020.849687254697;10033.996600339908;10046.346987445793;5501.14732216499;5560.749766260528;5565.026120428909;5569.721513924287;5573.665580065209;4967.453580106186;5106.15748401517;5131.230315452712;5137.768800403991;5152.896942061137;4036.233115708065;4064.9593504065174;4153.314703073959;4168.24971505132;4229.894252643709;1341.8255626768457;1345.051738524338;1365.9726805464034;1369.370089758722;1375.8968077394236;950.4107453378949;975.8048390321823;976.9408109305846;982.1062832822098;990.1039559198937;5676.744546495418;5748.885022299614;5879.735411906475;5903.76384944606;6070.180525629072;470.51066890433566;471.5873610590733;475.8310799666138;483.2678492084495;493.03365403808937;3976.6023397660583;4031.717779755389;4033.979830100831;4045;4106.876793696194;10417.427041512638;10687.412192329497;10720.624778132727;10722.142228621691;10765.515551800188;10639.468026598639;10643.73390665224;10663.626773062906;10671.57313707443;10704.678859634223;7382.114146302478;7581.241875812485;7665.271799179069;8043.39674524413;8170.264676179172;5665.688387138747;5747.339056008613;5784.132380142844;5814.912776308443;5925.111233315038;9310.534473276173;9350.906490935276;9518.904810951803;9567.043295670655;9600.711978640651;9583;9584.37701549397;9730.659426920023;9822.312438129262;9837.262205334771;7497.850042999218;7669.6548655309525;7726.227377262228;7789.6884124636645;7798.883016754867;8383.832323353621;8487.405881588476;8498.490090594583;8498.490090594583;8504.574771261536;7167.319104685047;7259.092613423322;7465.552066876005;7488.138864030706;7495.887561686688;7416.629168541659;7473.476856620202;7494.288042635941;7623;7679.5776232305525;6759.493038022069;6895.448364130958;6901.654917254017;6907.481938854506;6910.965445172742;4924.975375123101;4970.552650261494;4985.800567977385;4999.825006124768;5140.948590514196;5252.185911183773;5281.234221038005;5288.8413347599635;5379.811706590251;5435.23906653061 17:30:01 INFO - PROCESS | 13881 | |4;prototype.html;339.5348372729361;343.2020552216097;348.6043340808182;364.1860441912327;365.0781776015562;5582.525485333752;5582.86042848929;5593.83218503445;5615.354234263056;5656.7737290508385;5531.115021596545;5541.722913854312;5542.7782888684405;5562.163296718672;5569.941711074893;3817.7709337439705;4142.85500007499;4264.466941632296;4355.324924636687;4408.735475871442;4399.42807435033;4418.469783625953;4430.623397011242;4432.778361081933;4454.53227411122;4402.449693788277;4402.955970440286;4434.312681534351;4439.378487011821;4449.421575195236;4277.401163837066;4368.868933931987;4387.758673272969;4422.292433210687;4447.932496200905;3898.7465814721954;3899.660203877679;3907.628775266345;3911.5306163260307;3917.099067214528;5321.5210631043;5369.463053694639;5399.7030163341;5408.783648654088;5433.864153396196;4943.612846248845;5004.199328107486;5036.647434679574;5043.974780126113;5069.493050694938;5817.214676018725;5817.505512031483;5825.155352473867;5826.766929322822;5836.766529338822;4330.848420305274;4334.609885110355;4335.176316499855;4336.718113322624;4350.216960947028;5749.59752817303;6005.609635373687;6028.517718582503;6061.51507879373;6077.453029227391;4252.277112890816;4275.893102672396;4281.422008028939;4283.614474697292;4286.785660717014;4347.434923427563;4363.192809330284;4372.5352007077345;4379.671524635665;4381.255186618282;4891.364122664102;4938.827141050046;4977.303177555145;4987.1771157759285;4990.90018199634;5852.4440178183;5856.619319744203;5865.560082993792;5884.205632239678;5906.704664766745;1429.8632587093286;1429.9499517516838;1438.4893362856244;1438.7266419380285;1439.4098419648103;940.8682784410188;989.8762654668167;992.4591097851688;1019.7501612104934;1026.7689769801884;5445.809396671098;5489.58828087895;5505.724713764376;5531.695756733418;5587.245721827582;5811.198528456108;5827.475527202488;5836.365817571087;5854.238948936696;5866.472017518358;5237.3453318335205;5507.9449205507435;5543.944560554342;5573.442655734475;5600.691961942132;3063.7089476499696;3067.4478593852873;3074.8155110692983;3076.8000079994727;3100.875964961376;5934.258217722785;5958.314793798769;6087.208662873798;6087.873743357493;6123.08153776937;5853.88292234153;5864.970675146597;5870.767138900793;5902.642392249721;5951.821445356646;6176.907346389808;6190.938090619126;6220.688965551704;6248.218972628421;6307.842303942438;5967.9701601491715;5990.910136348046;6010.368911264254;6066;6086.543509236736;5883.499902508334;5885.705714714161;5923.644581325134;5932.911006334994;5982.162497250301;6298.811035668938;6312.5581209314905;6319.968400158154;6384.904226436514;6396.5373331266865;4314.633256173261;4354.542773008915;4368.082702632356;4371.650267978618;4382.23310920594;6009.964967691288;6020.759169633166;6022.909656355246;6038.63768173911;6061.757529698939;5904.903759165434;5906.557008224315;5914.852128696817;5936.28764548257;5940.7919723348905;5659.830205093854;5839.649621022752;5868.794592189253;5882.441168089024;5925.911111333247;5839.35767065614;5850.327212370632;5859.765609375748;5864.296284445723;5882.852928676817;5720.256366672473;5851.795187168599;5870;5884;5895.9115613266695;5734.702546035963;5738.540916726568;5740.3685594585395;5743.167240750151;5761.5390768739235 17:30:01 INFO - PROCESS | 13881 | |5;yui.html;723.7213672735999;745.3105877063718;791.8020494876281;836.4604829884723;871.2724874729603;14220.075695079813;14799.18604476752;14869.55391338259;14922.701545969088;14962.775558366606;14215.644608884782;14519.49181778638;14522.636934076627;14536;14555.927220363883;829.6266679993996;834.3658819297348;838.4591938199858;844.8648216285395;847.4152834544176;840.9032961209448;842.0989541190928;843.0305149078547;843.4559708987699;843.6035063520136;869.1395518436765;873.4104479476359;873.8121303919656;877.1579283887476;878.9868151977726;864.6973559254274;865.212656482601;865.446114486729;865.4850364033422;873.3799002708084;638.7285403703454;644.5069521815815;645.2805122288661;645.893427584448;647.1683886206202;12901.935490322488;12929.094963352569;12976.870231297755;12978.35108244584;13021;12538.122331436804;12718.10973231874;12770.80843787344;12778.680532986657;12885.033622478351;11091.223614346998;11104.833427498594;11146.665600032013;11181.385023823686;11189.328640281608;3614.765040272374;3702.241040586673;3704.2591481703766;3764.1530655602546;3816.427535869614;60802.695986519786;60978;62526.37473625251;62776.05835912465;64766.352336476506;9281.164695177331;9444.763880903032;9490.240780737524;9506.90493095074;9700.36947598418;18528.629427411375;18642.44072677822;18655.90672046631;18809;18831.81168188328;7817.452778305464;8063.959680201679;8090.676372945134;8234.341252699769;8247.628856701464;4405.757683327448;4512.52618475062;4532.9320060199125;4534.455865296186;4565.748883811356;3276.1973316537124;3377.4427219508507;3379.6113446953423;3380.2056516718553;3382.1713680148027;582.1529674323849;587.8589138606703;596.4095545410099;601.9969900150471;603.4508597176548;647.2136354329513;668.5019660353069;677.2448719677623;682.9351211634887;686.1354693086747;9380.202682771904;9502.097300756417;9570.90429095714;10016.679528989958;10081.49592520371;556.3324011186593;629.2417636747708;641.6759536434071;662.2648859765657;674.1236392689484;4553.817847286072;4625.32932724753;4852.369192005017;4855.883146876238;4897.335669676944;53831;72423.91364129542;89714;89968;90997.54501227583;75732;76820.61589692127;78386;79071;79693.60153199197;68981.3101868985;69685.65157174182;70576.88269351928;70839;71052.64473677598;9354.485503297385;9562.18721408688;9718.805623887623;9770.609175632895;10038.447885366082;44507.77746111378;45551.31673024974;45892;46108.53891461043;46862.76568617135;59742.40257597368;61131.69434152801;62974.370256296854;63096;63473.68263158655;13361.13152645075;13499.46002159942;13567.660808479866;14095.154290742588;14144.504942326968;14215.928920355746;14300.856991429953;14543.673012317979;14655.193964331638;15050.698986020438;13654.658633534242;13817.101888377223;13911.791323129959;14065.085769424955;14772.261386930826;12780.808287875503;13505;13921.860781392461;14419.85580144185;14727.55817325482;12765.8085128725;13202.273874936971;13475.124116932368;13922.651933701738;14166.150030998173;11380.772384552429;11531.365774882126;11748.88251117478;11844.76310473803;12167.756644866877;11549.595764148215;12034.277943323428;12097.647651894238;12368;12375.814362784746 17:30:01 INFO - PROCESS | 13881 | __end_tp_report 17:30:01 INFO - PROCESS | 13881 | __start_cc_report 17:30:01 INFO - PROCESS | 13881 | _x_x_mozilla_cycle_collect,316 17:30:01 INFO - PROCESS | 13881 | __end_cc_report 17:30:01 INFO - PROCESS | 13881 | __startTimestamp1480555801051__endTimestamp 17:30:01 INFO - PROCESS | 13881 | 17:30:01 INFO - PROCESS | 13881 | ------- Summary: start ------- 17:30:01 INFO - PROCESS | 13881 | Number of tests: 6 17:30:01 INFO - PROCESS | 13881 | 17:30:01 INFO - PROCESS | 13881 | [#0] dojo.html Cycles:165 Average:5597.90 Median:5792.97 stddev:620.96 (10.7%) stddev-sans-first:594.65 17:30:01 INFO - PROCESS | 13881 | Values: 3238.8 3256.4 3276.5 3280.1 3290.3 5543.2 5554.0 5570.2 5576.9 5590.0 5615.4 5742.5 5748.9 5758.3 5769.1 5180.6 5216.8 5257.6 5271.2 5274.3 5279.5 5287.3 5301.6 5303.8 5311.0 5049.8 5050.9 5285.9 5288.7 5319.7 5135.4 5146.7 5147.6 5167.9 5194.5 5112.4 5128.8 5138.4 5140.2 5206.9 5598.4 5620.9 5699.7 5716.6 5749.7 5895.4 5951.5 5974.3 5994.0 5994.0 5984.5 5991.7 6030.9 6037.2 6042.0 5546.5 5598.4 5622.4 5631.9 5638.3 6085.0 6093.8 6143.3 6192.5 6206.6 5918.7 5937.1 5944.8 5947.6 5951.7 5935.9 6033.8 6040.8 6043.1 6049.0 5871.5 5890.5 5892.5 5972.0 5976.2 5830.0 5927.5 5931.7 5932.6 5933.1 4559.9 4579.5 4609.2 4628.7 4646.5 4083.9 4087.1 4121.3 4137.6 4186.0 5724.7 5726.2 5742.8 5746.4 5775.4 5857.1 5934.1 5952.4 5968.8 5981.3 5631.4 5646.4 5664.4 5670.1 5744.4 5109.2 5131.1 5142.4 5156.3 5162.7 6183.4 6215.8 6240.5 6260.7 6290.2 5868.7 5883.4 5999.3 6016.9 6024.2 6348.6 6350.5 6361.5 6366.1 6372.1 5925.1 5937.7 5950.1 6009.8 6017.3 5848.9 5943.0 6009.2 6118.1 6135.5 5878.8 5886.6 5887.7 5903.6 5932.3 5893.5 5911.3 5916.1 5917.1 5921.1 5675.9 5773.1 5883.4 5886.4 5888.1 5793.0 5814.3 5819.8 5832.2 5882.3 5667.9 5710.1 5721.5 5733.3 5733.4 17:30:01 INFO - PROCESS | 13881 | 17:30:01 INFO - PROCESS | 13881 | [#1] ext.html Cycles:180 Average:62319.33 Median:44685.55 stddev:118856.54 (266.0%) stddev-sans-first:119099.59 17:30:01 INFO - PROCESS | 13881 | Values: 589.0 614.7 644.1 660.3 667.6 44740.6 45598.2 45659.3 48866.5 48895.0 46701.5 46818.0 46837.8 47264.3 47419.0 8767.3 8851.3 8868.2 8918.3 8950.2 8918.6 8928.2 8967.3 8972.5 9016.1 9000.5 9025.5 9058.5 9063.0 9072.8 8938.6 8973.7 9010.5 9025.0 9030.5 8834.4 8839.5 8872.7 8926.9 8928.8 43505.0 44186.3 44306.3 44322.8 44327.6 3589.8 3873.2 4061.3 4112.8 4370.6 33855.3 33890.0 34078.7 34252.7 34276.8 4315.0 4333.3 4346.9 4357.5 4440.7 343936.0 346697.0 348150.0 349554.0 350398.0 66420.0 66761.3 66768.7 66855.7 67017.7 68504.0 68786.3 68906.7 69100.0 69166.7 16681.9 16873.8 16889.5 16891.9 16967.7 14098.3 14120.8 14192.5 14216.7 14284.4 20025.1 20345.0 20507.9 20602.8 20652.7 7268.5 7474.9 7684.1 7695.3 7790.8 978.5 1054.6 1078.6 1150.0 1200.4 32741.7 32837.3 33001.6 34193.3 34416.1 1109.2 1169.9 1178.9 1184.4 1241.3 17061.3 17571.8 17836.4 18292.4 18502.2 527348.0 527665.0 531817.0 533342.0 533355.0 61845.7 62366.4 62485.0 62591.7 62743.7 1430.1 1441.7 1443.1 1447.3 1476.1 31848.8 33966.5 34368.5 34445.0 34559.5 55202.0 55853.0 56145.7 56349.7 56394.4 448117.0 449431.0 450411.0 451793.0 453504.0 30613.4 30773.0 30861.5 30996.7 31184.2 50760.0 50878.0 51650.0 54881.5 56042.4 42013.6 42769.1 44286.6 45314.1 46581.0 42670.8 44272.3 44771.0 45200.8 45520.3 43869.8 44649.6 44721.6 44745.6 46835.5 38366.2 38760.2 38798.6 39329.8 39412.4 30173.8 30254.2 30299.0 30514.8 30896.8 17:30:01 INFO - PROCESS | 13881 | 17:30:01 INFO - PROCESS | 13881 | [#2] jquery.html Cycles:180 Average:28169.33 Median:2535.04 stddev:77526.27 (3058.2%) stddev-sans-first:77715.77 17:30:01 INFO - PROCESS | 13881 | Values: 428.0 430.2 438.1 440.6 451.7 18651.2 19460.6 20272.7 20368.3 20389.8 17203.0 19133.8 19584.6 19795.0 19859.2 5179.5 5406.4 5442.4 5443.6 5446.9 5256.4 5343.6 5377.2 5443.4 5468.3 5413.1 5423.0 5424.3 5429.0 5431.9 5370.0 5413.2 5421.2 5509.0 5773.9 5260.0 5283.8 5307.4 5312.7 5324.7 22993.2 23459.9 24136.0 24155.8 24170.0 2519.8 2550.3 2631.2 2705.4 3000.7 10774.5 11283.9 11504.1 12578.6 15523.7 1993.5 2009.1 2029.0 2058.7 2071.8 81875.6 82069.6 82580.6 83146.0 85926.1 9723.9 10282.7 10390.0 10453.0 10474.9 13826.0 13846.4 13871.2 13886.1 13935.5 8192.0 8431.6 8467.8 8474.8 8665.6 8650.2 8767.7 8808.0 8883.0 9040.3 4175.5 4205.7 4296.3 4305.5 4530.0 2087.6 2101.1 2133.6 2134.6 2138.2 927.5 989.0 1014.5 1061.7 1065.4 19945.8 20764.9 20839.9 20987.5 21047.6 968.4 1014.6 1017.2 1025.6 1031.7 10668.1 11603.3 11605.7 11653.9 11665.6 156257.0 505911.0 506501.0 523068.0 530382.0 90980.0 92846.0 94969.0 96703.5 98762.5 993.8 998.7 1008.3 1021.8 1023.5 17423.0 17967.9 18122.4 18150.6 18183.4 43235.4 43735.0 43986.0 44916.1 45450.0 58895.7 59464.7 59683.0 60013.1 61042.4 8665.7 8713.2 8861.5 8932.3 9052.3 11419.8 13741.7 13746.7 13909.9 14056.2 11782.5 12153.1 12295.4 12326.3 12329.1 11754.7 11912.8 11969.2 11989.4 12263.1 12147.8 12178.3 12224.4 12621.2 12732.5 8196.4 8296.1 8368.2 8373.0 9201.3 10518.4 12458.6 12501.9 12603.7 12852.2 17:30:01 INFO - PROCESS | 13881 | 17:30:01 INFO - PROCESS | 13881 | [#3] mootools.html Cycles:180 Average:5728.99 Median:5139.36 stddev:3145.71 (61.2%) stddev-sans-first:3137.86 17:30:01 INFO - PROCESS | 13881 | Values: 1419.3 1486.0 1573.7 1762.3 1763.4 7850.0 8045.0 8220.0 8703.3 8751.6 8278.7 8592.7 8594.3 8701.2 8752.3 2459.5 2498.0 2512.1 2514.7 2518.1 2469.7 2554.2 2554.6 2555.5 2559.5 2424.8 2463.7 2507.4 2508.9 2509.6 2410.7 2429.4 2431.7 2432.8 2454.1 2446.4 2460.9 2471.2 2486.5 2489.0 8736.7 8737.7 8746.0 8768.6 8823.0 5437.9 5601.8 5612.2 5620.8 5623.4 3376.3 3429.4 3460.9 3466.7 3473.9 1123.2 1123.8 1147.6 1186.3 1230.8 11786.0 11818.9 11868.2 11878.2 11879.3 4543.6 4584.8 4696.7 4704.4 4856.5 9943.6 9979.8 10020.8 10034.0 10046.3 5501.1 5560.7 5565.0 5569.7 5573.7 4967.5 5106.2 5131.2 5137.8 5152.9 4036.2 4065.0 4153.3 4168.2 4229.9 1341.8 1345.1 1366.0 1369.4 1375.9 950.4 975.8 976.9 982.1 990.1 5676.7 5748.9 5879.7 5903.8 6070.2 470.5 471.6 475.8 483.3 493.0 3976.6 4031.7 4034.0 4045.0 4106.9 10417.4 10687.4 10720.6 10722.1 10765.5 10639.5 10643.7 10663.6 10671.6 10704.7 7382.1 7581.2 7665.3 8043.4 8170.3 5665.7 5747.3 5784.1 5814.9 5925.1 9310.5 9350.9 9518.9 9567.0 9600.7 9583.0 9584.4 9730.7 9822.3 9837.3 7497.9 7669.7 7726.2 7789.7 7798.9 8383.8 8487.4 8498.5 8498.5 8504.6 7167.3 7259.1 7465.6 7488.1 7495.9 7416.6 7473.5 7494.3 7623.0 7679.6 6759.5 6895.4 6901.7 6907.5 6911.0 4925.0 4970.6 4985.8 4999.8 5140.9 5252.2 5281.2 5288.8 5379.8 5435.2 17:30:01 INFO - PROCESS | 13881 | 17:30:01 INFO - PROCESS | 13881 | [#4] prototype.html Cycles:180 Average:4923.92 Median:5582.69 stddev:1445.03 (25.9%) stddev-sans-first:1407.52 17:30:01 INFO - PROCESS | 13881 | Values: 339.5 343.2 348.6 364.2 365.1 5582.5 5582.9 5593.8 5615.4 5656.8 5531.1 5541.7 5542.8 5562.2 5569.9 3817.8 4142.9 4264.5 4355.3 4408.7 4399.4 4418.5 4430.6 4432.8 4454.5 4402.4 4403.0 4434.3 4439.4 4449.4 4277.4 4368.9 4387.8 4422.3 4447.9 3898.7 3899.7 3907.6 3911.5 3917.1 5321.5 5369.5 5399.7 5408.8 5433.9 4943.6 5004.2 5036.6 5044.0 5069.5 5817.2 5817.5 5825.2 5826.8 5836.8 4330.8 4334.6 4335.2 4336.7 4350.2 5749.6 6005.6 6028.5 6061.5 6077.5 4252.3 4275.9 4281.4 4283.6 4286.8 4347.4 4363.2 4372.5 4379.7 4381.3 4891.4 4938.8 4977.3 4987.2 4990.9 5852.4 5856.6 5865.6 5884.2 5906.7 1429.9 1429.9 1438.5 1438.7 1439.4 940.9 989.9 992.5 1019.8 1026.8 5445.8 5489.6 5505.7 5531.7 5587.2 5811.2 5827.5 5836.4 5854.2 5866.5 5237.3 5507.9 5543.9 5573.4 5600.7 3063.7 3067.4 3074.8 3076.8 3100.9 5934.3 5958.3 6087.2 6087.9 6123.1 5853.9 5865.0 5870.8 5902.6 5951.8 6176.9 6190.9 6220.7 6248.2 6307.8 5968.0 5990.9 6010.4 6066.0 6086.5 5883.5 5885.7 5923.6 5932.9 5982.2 6298.8 6312.6 6320.0 6384.9 6396.5 4314.6 4354.5 4368.1 4371.7 4382.2 6010.0 6020.8 6022.9 6038.6 6061.8 5904.9 5906.6 5914.9 5936.3 5940.8 5659.8 5839.6 5868.8 5882.4 5925.9 5839.4 5850.3 5859.8 5864.3 5882.9 5720.3 5851.8 5870.0 5884.0 5895.9 5734.7 5738.5 5740.4 5743.2 5761.5 17:30:01 INFO - PROCESS | 13881 | 17:30:01 INFO - PROCESS | 13881 | [#5] yui.html Cycles:180 Average:17671.20 Median:4854.13 stddev:23056.72 (475.0%) stddev-sans-first:23086.28 17:30:01 INFO - PROCESS | 13881 | Values: 723.7 745.3 791.8 836.5 871.3 14220.1 14799.2 14869.6 14922.7 14962.8 14215.6 14519.5 14522.6 14536.0 14555.9 829.6 834.4 838.5 844.9 847.4 840.9 842.1 843.0 843.5 843.6 869.1 873.4 873.8 877.2 879.0 864.7 865.2 865.4 865.5 873.4 638.7 644.5 645.3 645.9 647.2 12901.9 12929.1 12976.9 12978.4 13021.0 12538.1 12718.1 12770.8 12778.7 12885.0 11091.2 11104.8 11146.7 11181.4 11189.3 3614.8 3702.2 3704.3 3764.2 3816.4 60802.7 60978.0 62526.4 62776.1 64766.4 9281.2 9444.8 9490.2 9506.9 9700.4 18528.6 18642.4 18655.9 18809.0 18831.8 7817.5 8064.0 8090.7 8234.3 8247.6 4405.8 4512.5 4532.9 4534.5 4565.7 3276.2 3377.4 3379.6 3380.2 3382.2 582.2 587.9 596.4 602.0 603.5 647.2 668.5 677.2 682.9 686.1 9380.2 9502.1 9570.9 10016.7 10081.5 556.3 629.2 641.7 662.3 674.1 4553.8 4625.3 4852.4 4855.9 4897.3 53831.0 72423.9 89714.0 89968.0 90997.5 75732.0 76820.6 78386.0 79071.0 79693.6 68981.3 69685.7 70576.9 70839.0 71052.6 9354.5 9562.2 9718.8 9770.6 10038.4 44507.8 45551.3 45892.0 46108.5 46862.8 59742.4 61131.7 62974.4 63096.0 63473.7 13361.1 13499.5 13567.7 14095.2 14144.5 14215.9 14300.9 14543.7 14655.2 15050.7 13654.7 13817.1 13911.8 14065.1 14772.3 12780.8 13505.0 13921.9 14419.9 14727.6 12765.8 13202.3 13475.1 13922.7 14166.2 11380.8 11531.4 11748.9 11844.8 12167.8 11549.6 12034.3 12097.6 12368.0 12375.8 17:30:01 INFO - PROCESS | 13881 | -------- Summary: end -------- 17:30:01 INFO - PROCESS | 13881 | 17:30:01 INFO - TEST-INFO | 13881: exit 0 17:30:01 INFO - TEST-OK | dromaeo_css | took 1113135ms 17:30:01 INFO - TEST-START | kraken 17:30:01 INFO - operating with platform_type : linux_ 17:30:01 INFO - Initialising browser for kraken test... 17:30:01 INFO - TEST-INFO | started process 14260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf5uo5v/profile http://localhost:51024/getInfo.html) 17:30:06 INFO - PROCESS | 14260 | __metrics Screen width/height:1600/1200 17:30:06 INFO - PROCESS | 14260 | colorDepth:24 17:30:06 INFO - PROCESS | 14260 | Browser inner width/height: 1024/697 17:30:06 INFO - PROCESS | 14260 | __metrics 17:30:06 ERROR - PROCESS | 14260 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 17:30:07 INFO - TEST-INFO | 14260: exit 0 17:30:07 INFO - Browser initialized. 17:30:07 INFO - Running cycle 1/1 for kraken test... 17:30:07 INFO - TEST-INFO | started process 14392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf5uo5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:19 INFO - PROCESS | 14392 | RSS: Main: 152088576 17:30:19 INFO - PROCESS | 14392 | 17:30:22 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-beat-detection) 17:30:23 INFO - PROCESS | 14392 | RSS: Main: 157396992 17:30:23 INFO - PROCESS | 14392 | 17:30:25 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-dft) 17:30:26 INFO - PROCESS | 14392 | RSS: Main: 155443200 17:30:26 INFO - PROCESS | 14392 | 17:30:29 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-fft) 17:30:29 INFO - PROCESS | 14392 | RSS: Main: 156262400 17:30:29 INFO - PROCESS | 14392 | 17:30:31 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51024/tests/kraken/driver.html?testName=audio-oscillator) 17:30:32 INFO - PROCESS | 14392 | RSS: Main: 155447296 17:30:32 INFO - PROCESS | 14392 | 17:30:34 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:35 INFO - PROCESS | 14392 | RSS: Main: 155111424 17:30:35 INFO - PROCESS | 14392 | 17:30:38 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51024/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:38 INFO - PROCESS | 14392 | RSS: Main: 158568448 17:30:38 INFO - PROCESS | 14392 | 17:30:42 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51024/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:42 INFO - PROCESS | 14392 | RSS: Main: 158679040 17:30:42 INFO - PROCESS | 14392 | 17:30:45 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51024/tests/kraken/driver.html?testName=json-parse-financial) 17:30:46 INFO - PROCESS | 14392 | RSS: Main: 158576640 17:30:46 INFO - PROCESS | 14392 | 17:30:47 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:48 INFO - PROCESS | 14392 | RSS: Main: 158371840 17:30:48 INFO - PROCESS | 14392 | 17:30:49 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:50 INFO - PROCESS | 14392 | RSS: Main: 157839360 17:30:50 INFO - PROCESS | 14392 | 17:30:52 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:53 INFO - PROCESS | 14392 | RSS: Main: 157945856 17:30:53 INFO - PROCESS | 14392 | 17:30:55 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:56 INFO - PROCESS | 14392 | RSS: Main: 157876224 17:30:56 INFO - PROCESS | 14392 | 17:30:59 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:59 INFO - PROCESS | 14392 | RSS: Main: 158093312 17:30:59 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:51024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51024/tests/kraken/driver.html?testName=ai-astar) 17:31:01 INFO - PROCESS | 14392 | RSS: Main: 159707136 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | __start_tp_report 17:31:01 INFO - PROCESS | 14392 | _x_x_mozilla_page_load 17:31:01 INFO - PROCESS | 14392 | _x_x_mozilla_page_load_details 17:31:01 INFO - PROCESS | 14392 | |i|pagename|runs| 17:31:01 INFO - PROCESS | 14392 | |0;ai-astar;101;112;111;112;114;110;111;113;111;110 17:31:01 INFO - PROCESS | 14392 | |1;audio-beat-detection;148;128;123;156;126;128;124;122;146;123 17:31:01 INFO - PROCESS | 14392 | |2;audio-dft;164;162;165;163;162;163;161;163;162;163 17:31:01 INFO - PROCESS | 14392 | |3;audio-fft;75;74;75;102;76;75;75;75;99;75 17:31:01 INFO - PROCESS | 14392 | |4;audio-oscillator;83;82;115;83;83;81;94;81;83;103 17:31:01 INFO - PROCESS | 14392 | |5;imaging-gaussian-blur;118;119;117;117;117;117;119;116;119;118 17:31:01 INFO - PROCESS | 14392 | |6;imaging-darkroom;148;148;146;146;148;147;147;146;149;148 17:31:01 INFO - PROCESS | 14392 | |7;imaging-desaturate;86;85;85;85;87;86;85;85;86;85 17:31:01 INFO - PROCESS | 14392 | |8;json-parse-financial;51;50;54;52;53;50;53;51;53;51 17:31:01 INFO - PROCESS | 14392 | |9;json-stringify-tinderbox;58;60;58;59;59;59;60;59;59;58 17:31:01 INFO - PROCESS | 14392 | |10;stanford-crypto-aes;76;84;77;76;77;76;76;75;76;75 17:31:01 INFO - PROCESS | 14392 | |11;stanford-crypto-ccm;137;132;128;127;131;145;133;131;177;126 17:31:01 INFO - PROCESS | 14392 | |12;stanford-crypto-pbkdf2;155;159;159;157;158;157;163;165;156;159 17:31:01 INFO - PROCESS | 14392 | |13;stanford-crypto-sha256-iterative;64;65;66;63;64;67;62;65;62;61 17:31:01 INFO - PROCESS | 14392 | __end_tp_report 17:31:01 INFO - PROCESS | 14392 | __start_cc_report 17:31:01 INFO - PROCESS | 14392 | _x_x_mozilla_cycle_collect,824 17:31:01 INFO - PROCESS | 14392 | __end_cc_report 17:31:01 INFO - PROCESS | 14392 | __startTimestamp1480555861738__endTimestamp 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | ------- Summary: start ------- 17:31:01 INFO - PROCESS | 14392 | Number of tests: 14 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:3.57 (3.2%) stddev-sans-first:1.33 17:31:01 INFO - PROCESS | 14392 | Values: 101.0 112.0 111.0 112.0 114.0 110.0 111.0 113.0 111.0 110.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:128.00 stddev:12.56 (9.8%) stddev-sans-first:11.99 17:31:01 INFO - PROCESS | 14392 | Values: 148.0 128.0 123.0 156.0 126.0 128.0 124.0 122.0 146.0 123.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 17:31:01 INFO - PROCESS | 14392 | Values: 164.0 162.0 165.0 163.0 162.0 163.0 161.0 163.0 162.0 163.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.00 stddev:10.79 (14.4%) stddev-sans-first:11.28 17:31:01 INFO - PROCESS | 14392 | Values: 75.0 74.0 75.0 102.0 76.0 75.0 75.0 75.0 99.0 75.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:83.00 stddev:11.63 (14.0%) stddev-sans-first:12.15 17:31:01 INFO - PROCESS | 14392 | Values: 83.0 82.0 115.0 83.0 83.0 81.0 94.0 81.0 83.0 103.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:1.06 (0.9%) stddev-sans-first:1.12 17:31:01 INFO - PROCESS | 14392 | Values: 118.0 119.0 117.0 117.0 117.0 117.0 119.0 116.0 119.0 118.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 17:31:01 INFO - PROCESS | 14392 | Values: 148.0 148.0 146.0 146.0 148.0 147.0 147.0 146.0 149.0 148.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 17:31:01 INFO - PROCESS | 14392 | Values: 86.0 85.0 85.0 85.0 87.0 86.0 85.0 85.0 86.0 85.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.50 stddev:1.40 (2.7%) stddev-sans-first:1.45 17:31:01 INFO - PROCESS | 14392 | Values: 51.0 50.0 54.0 52.0 53.0 50.0 53.0 51.0 53.0 51.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 17:31:01 INFO - PROCESS | 14392 | Values: 58.0 60.0 58.0 59.0 59.0 59.0 60.0 59.0 59.0 58.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:2.62 (3.4%) stddev-sans-first:2.76 17:31:01 INFO - PROCESS | 14392 | Values: 76.0 84.0 77.0 76.0 77.0 76.0 76.0 75.0 76.0 75.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:132.50 stddev:15.20 (11.5%) stddev-sans-first:16.12 17:31:01 INFO - PROCESS | 14392 | Values: 137.0 132.0 128.0 127.0 131.0 145.0 133.0 131.0 177.0 126.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:159.00 stddev:3.08 (1.9%) stddev-sans-first:2.95 17:31:01 INFO - PROCESS | 14392 | Values: 155.0 159.0 159.0 157.0 158.0 157.0 163.0 165.0 156.0 159.0 17:31:01 INFO - PROCESS | 14392 | 17:31:01 INFO - PROCESS | 14392 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.91 (3.0%) stddev-sans-first:2.03 17:31:01 INFO - PROCESS | 14392 | Values: 64.0 65.0 66.0 63.0 64.0 67.0 62.0 65.0 62.0 61.0 17:31:01 INFO - PROCESS | 14392 | -------- Summary: end -------- 17:31:01 INFO - PROCESS | 14392 | 17:31:02 INFO - TEST-INFO | 14392: exit 0 17:31:02 INFO - TEST-OK | kraken | took 60981ms 17:31:02 INFO - SUITE-END | took 1174s 17:31:02 INFO - Completed test suite (00:19:34) 17:31:02 INFO - javascript benchmark 17:31:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7388.996151715943, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3238.753080064175, 3256.446404111301, 3276.5249038889347, 3280.1307653471818, 3290.2596915693966, 5543.223948647193, 5553.972230138844, 5570.192322113291, 5576.944230557693, 5590.049691552435, 5615.382307946133, 5742.511886489653, 5748.885022299552, 5758.309002919645, 5769.076947688371, 5180.637355385115, 5216.765245563959, 5257.631965762398, 5271.2356708277275, 5274.314339135907, 5279.524842764151, 5287.286216360781, 5301.575873930076, 5303.787848486075, 5311.017461769566, 5049.823256186034, 5050.898982020358, 5285.894282114375, 5288.735563221842, 5319.654222475527, 5135.35808023997, 5146.691198528081, 5147.562457191143, 5167.9224811627855, 5194.454582268883, 5112.386513618352, 5128.769205385729, 5138.3577052868395, 5140.1518749406305, 5206.895862082775, 5598.44015598441, 5620.91568626471, 5699.68651724155, 5716.628419152742, 5749.741261643194, 5895.410458954113, 5951.49412299955, 5974.3428222895445, 5993.9700301498215, 5994.0, 5984.521238300926, 5991.730372133265, 6030.879382412371, 6037.245344331958, 6042.0332746760305, 5546.500814926676, 5598.440155984369, 5622.409646987048, 5631.8592035199445, 5638.295213098363, 6085.0, 6093.756249750049, 6143.32423433422, 6192.535559833031, 6206.627602343874, 5918.674472904032, 5937.050071988461, 5944.762209511658, 5947.613405128653, 5951.672658003765, 5935.881282374415, 6033.758649653964, 6040.7583696651645, 6043.09353596964, 6049.0, 5871.4715675589405, 5890.4698577128265, 5892.528597712173, 5971.9701401493585, 5976.223090998143, 5829.979753543113, 5927.496162826208, 5931.673757943355, 5932.555058370639, 5933.110033494924, 4559.908801823945, 4579.496255411902, 4609.2394754865745, 4628.722276663411, 4646.512116227747, 4083.9183216335505, 4087.141700242923, 4121.29937910556, 4137.627613514798, 4185.9581404185565, 5724.685142317213, 5726.169705392695, 5742.827715168552, 5746.396628353963, 5775.364709881909, 5857.092150716646, 5934.139549765347, 5952.4047595241, 5968.791092311748, 5981.252343457068, 5631.352394474606, 5646.378898321182, 5664.376918538957, 5670.092785154438, 5744.396838331999, 5109.20807274873, 5131.076406246912, 5142.382914050338, 5156.278121063054, 5162.741862906914, 6183.350748171557, 6215.844603884849, 6240.53196010292, 6260.749570017239, 6290.150829638032, 5868.677222752619, 5883.35283118848, 5999.280086389661, 6016.939830601813, 6024.216851809237, 6348.555601107878, 6350.4919606432295, 6361.522885783677, 6366.108744775643, 6372.107904893226, 5925.111233315038, 5937.673427961504, 5950.077737950624, 6009.819705408845, 6017.330469836127, 5848.853778655397, 5943.049112142036, 6009.2188015557695, 6118.131909153847, 6135.5082808396355, 5878.794242201502, 5886.558508111994, 5887.7056147191615, 5903.557233207441, 5932.288125424977, 5893.469587737124, 5911.3201981772645, 5916.142159386951, 5917.142014407973, 5921.111833224878, 5675.914861277001, 5773.076307790901, 5883.411658834254, 5886.3525012247765, 5888.116782482491, 5792.9710351447975, 5814.331351894586, 5819.79630712923, 5832.212651292021, 5882.264716910387, 5667.886642267049, 5710.143478478261, 5721.542276617944, 5733.283339582552, 5733.426657334233], "value": 5556.668681365707, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.9705514724266, 614.7203022624706, 644.1239913717345, 660.33966033966, 667.5660820466693, 44740.552594474044, 45598.17607295708, 45659.315110273375, 48866.51133488673, 48895.0, 46701.53298467014, 46818.0, 46837.765811170895, 47264.291035634495, 47419.0, 8767.342449316311, 8851.33614978876, 8868.157525035143, 8918.28653707705, 8950.194482496574, 8918.598663060178, 8928.19646231839, 8967.327450441211, 8972.46165230085, 9016.098390160996, 9000.549972501381, 9025.548722563846, 9058.456492610432, 9063.048379920112, 9072.773180670503, 8938.64245430182, 8973.730788076367, 9010.54947252638, 9025.0, 9030.45817250967, 8834.381593288472, 8839.46963182211, 8872.689455869013, 8926.910730892672, 8928.776780580538, 43505.0, 44186.33720494195, 44306.33540496895, 44322.778386108184, 44327.55672443299, 3589.766665166756, 3873.1672690371706, 4061.2689715851134, 4112.835486580533, 4370.562943705604, 33855.32289354199, 33890.0, 34078.659213407795, 34252.6574734252, 34276.82861585701, 4314.95039856069, 4333.306670932636, 4346.891327716832, 4357.477102747659, 4440.666949978732, 343936.0, 346697.0, 348150.0, 349554.0, 350398.0, 66420.0, 66761.33238667648, 66768.6661566689, 66855.66572167107, 67017.66491167514, 68504.0, 68786.312136878, 68906.65546672334, 69100.0, 69166.65416672884, 16681.91659041721, 16873.831261687224, 16889.493315200565, 16891.915540422466, 16967.660646786993, 14098.295085245696, 14120.788188177186, 14192.503262385973, 14216.715665686628, 14284.357203925849, 20025.09887055086, 20345.0, 20507.897460512602, 20602.793972060386, 20652.690209646866, 7268.45486588508, 7474.887876681854, 7684.116326622398, 7695.268949449794, 7790.766277011699, 978.500964508106, 1054.593981317183, 1078.5631819113114, 1149.9995004346272, 1200.37580458163, 32741.672583273863, 32837.34325313528, 33001.575682629424, 34193.31613367719, 34416.13959650978, 1109.2124591540096, 1169.91225658076, 1178.876217997098, 1184.3959580613778, 1241.2924632959127, 17061.317547297967, 17571.824281757275, 17836.3757268495, 18292.359767408077, 18502.167402466654, 527348.0, 527665.0, 531817.0, 533342.0, 533355.0, 61845.69077154585, 62366.376336236965, 62485.0, 62591.68704156541, 62743.6862815683, 1430.141914851081, 1441.7188648213498, 1443.0692203528874, 1447.3197597129333, 1476.0995792566525, 31848.840755796075, 33966.49050264298, 34368.48447273243, 34445.0, 34559.481607776404, 55202.0, 55853.0, 56145.71927140338, 56349.71825140848, 56394.43605564056, 448117.0, 449431.0, 450411.0, 451793.0, 453504.0, 30613.387732245676, 30773.0, 30861.537076944314, 30996.690033100283, 31184.22039449032, 50760.0, 50878.0, 51650.0, 54881.45118548923, 56042.43957560372, 42013.57986420097, 42769.144617108104, 44286.55713442953, 45314.093718124794, 46581.0, 42670.78664606657, 44272.335914960655, 44771.0, 45200.77399612981, 45520.317195241434, 43869.78065109654, 44649.55350446454, 44721.552784471736, 44745.55254447544, 46835.53164468312, 38366.232675346895, 38760.22479550337, 38798.61201388063, 39329.803350983064, 39412.40881386839, 30173.849130755083, 30254.243643909078, 30299.0, 30514.847425762728, 30896.84551577228], "value": 21307.285928002497, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.03744829954655, 430.1568924907182, 438.0887753472776, 440.55937085729664, 451.73121992414525, 18651.1606977686, 19460.610787784255, 20272.695909561367, 20368.287109951154, 20389.796102038974, 17202.96782193069, 19133.808661913376, 19584.608307833834, 19795.0, 19859.20563177475, 5179.507946745062, 5406.378266499363, 5442.374126975389, 5443.646162999412, 5446.891062178754, 5256.369235691723, 5343.572514198874, 5377.166539186433, 5443.401225865152, 5468.343798744137, 5413.052715774744, 5422.9728851355685, 5424.321959755031, 5429.0227759003365, 5431.864203394927, 5369.973150134244, 5413.188021796723, 5421.21392398102, 5508.9724551377385, 5773.913391299134, 5260.0, 5283.841484755463, 5307.442718514539, 5312.681239125626, 5324.680519168824, 22993.195238166583, 23459.882700586557, 24136.0, 24155.75844241553, 24170.0, 2519.7732204101717, 2550.298667866333, 2631.158029430583, 2705.3912869604183, 3000.7149320814488, 10774.515146818334, 11283.887161128365, 11504.137189710722, 12578.559750408784, 15523.689526209413, 1993.4717299915535, 2009.0758251204463, 2028.98985505073, 2058.691196320549, 2071.8031786980214, 81875.59062204651, 82069.58965205196, 82580.58709706474, 83145.99999999939, 85926.14073859244, 9723.902760972442, 10282.691519254435, 10390.012948769854, 10453.0, 10474.895251047392, 13825.963052771083, 13846.376913038937, 13871.167729936236, 13886.09740366873, 13935.512257070954, 8191.959040204761, 8431.620577074047, 8467.788305292293, 8474.830503390021, 8665.610047547876, 8650.221480066824, 8767.736967890973, 8807.987081485582, 8883.0, 9040.276777857756, 4175.54069052404, 4205.747655140702, 4296.2696341621995, 4305.547917468683, 4529.977350113229, 2087.6346639338053, 2101.109001898273, 2133.637281662121, 2134.5624147049816, 2138.219549864288, 927.4713413354323, 988.9554970026367, 1014.5333146752577, 1061.6549621373085, 1065.4033741105006, 19945.800541994686, 20764.896175519025, 20839.8958005209, 20987.475313117295, 21047.57904841925, 968.4237878462303, 1014.573878970834, 1017.2167431078176, 1025.646152077532, 1031.7214352124884, 10668.14654827612, 11603.303801771921, 11605.6518304451, 11653.941730291293, 11665.591704290478, 156257.0, 505911.0, 506501.0, 523068.0, 530382.0, 90980.0, 92846.0, 94969.0, 96703.51648241855, 98762.5061874686, 993.7565296502403, 998.7353351362041, 1008.2841182760176, 1021.8365061590258, 1023.4626820918928, 17423.041732704314, 17967.910160449115, 18122.365717199835, 18150.636987260445, 18183.363582275088, 43235.35146972735, 43735.0, 43986.0, 44916.10167796691, 45450.0, 58895.70552147212, 59464.70267648807, 59683.0, 60013.09980350386, 61042.38957610367, 8665.740027799176, 8713.215810577078, 8861.468311901306, 8932.330075244512, 9052.3210759192, 11419.771604568028, 13741.725165496435, 13746.65633359174, 13909.930450347683, 14056.226907519775, 11782.528698852293, 12153.149279550347, 12295.385230738248, 12326.32205228721, 12329.136960413043, 11754.706132346417, 11912.821307680566, 11969.222000570284, 11989.40052997364, 12263.141580089308, 12147.825091233351, 12178.269303841444, 12224.449899754354, 12621.242725436503, 12732.490700372251, 8196.42625016243, 8296.128906464975, 8368.24685778283, 8373.037100733494, 9201.263898888206, 10518.421486818299, 12458.626241212778, 12501.93749031249, 12603.74792504163, 12852.164609300366], "value": 9396.77087543318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.2690764256406, 1486.0118021515693, 1573.7009968106058, 1762.347931265432, 1763.4357005758154, 7850.0, 8045.034595848491, 8220.0, 8703.303735701145, 8751.562421878913, 8278.710245141421, 8592.699255526059, 8594.312455003601, 8701.216890479856, 8752.29981601472, 2459.495803360307, 2497.9750202497926, 2512.0705339024585, 2514.710808257046, 2518.0809004713333, 2469.6665950096776, 2554.246497283297, 2554.5784945484065, 2555.463352695927, 2559.539282929072, 2424.842385244953, 2463.6797216361847, 2507.448361360498, 2508.9372765680914, 2509.636102765107, 2410.7227668818136, 2429.356220601542, 2431.720352159498, 2432.8053755699502, 2454.0674543673467, 2446.412860913386, 2460.9261722148362, 2471.221565206972, 2486.539990101837, 2488.962665560018, 8736.694215702484, 8737.694180703646, 8746.037935827055, 8768.561571921442, 8823.029466758651, 5437.945620543823, 5601.80393686219, 5612.214289999403, 5620.803271885465, 5623.353314368859, 3376.2909788944353, 3429.4341433663417, 3460.913477163066, 3466.6879980801596, 3473.930521389583, 1123.219362543033, 1123.7752449510049, 1147.6270212181075, 1186.2763714134371, 1230.846144231971, 11786.0, 11818.881811181864, 11868.228565143238, 11878.168528203028, 11879.34663593502, 4543.5910768031035, 4584.839530616412, 4696.722089786451, 4704.364910737075, 4856.490068542823, 9943.552540135712, 9979.800403992025, 10020.849687254697, 10033.996600339908, 10046.346987445793, 5501.14732216499, 5560.749766260528, 5565.026120428909, 5569.721513924287, 5573.665580065209, 4967.453580106186, 5106.15748401517, 5131.230315452712, 5137.768800403991, 5152.896942061137, 4036.233115708065, 4064.9593504065174, 4153.314703073959, 4168.24971505132, 4229.894252643709, 1341.8255626768457, 1345.051738524338, 1365.9726805464034, 1369.370089758722, 1375.8968077394236, 950.4107453378949, 975.8048390321823, 976.9408109305846, 982.1062832822098, 990.1039559198937, 5676.744546495418, 5748.885022299614, 5879.735411906475, 5903.76384944606, 6070.180525629072, 470.51066890433566, 471.5873610590733, 475.8310799666138, 483.2678492084495, 493.03365403808937, 3976.6023397660583, 4031.717779755389, 4033.979830100831, 4045.0, 4106.876793696194, 10417.427041512638, 10687.412192329497, 10720.624778132727, 10722.142228621691, 10765.515551800188, 10639.468026598639, 10643.73390665224, 10663.626773062906, 10671.57313707443, 10704.678859634223, 7382.114146302478, 7581.241875812485, 7665.271799179069, 8043.39674524413, 8170.264676179172, 5665.688387138747, 5747.339056008613, 5784.132380142844, 5814.912776308443, 5925.111233315038, 9310.534473276173, 9350.906490935276, 9518.904810951803, 9567.043295670655, 9600.711978640651, 9583.0, 9584.37701549397, 9730.659426920023, 9822.312438129262, 9837.262205334771, 7497.850042999218, 7669.6548655309525, 7726.227377262228, 7789.6884124636645, 7798.883016754867, 8383.832323353621, 8487.405881588476, 8498.490090594583, 8498.490090594583, 8504.574771261536, 7167.319104685047, 7259.092613423322, 7465.552066876005, 7488.138864030706, 7495.887561686688, 7416.629168541659, 7473.476856620202, 7494.288042635941, 7623.0, 7679.5776232305525, 6759.493038022069, 6895.448364130958, 6901.654917254017, 6907.481938854506, 6910.965445172742, 4924.975375123101, 4970.552650261494, 4985.800567977385, 4999.825006124768, 5140.948590514196, 5252.185911183773, 5281.234221038005, 5288.8413347599635, 5379.811706590251, 5435.23906653061], "value": 4585.580920481916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.5348372729361, 343.2020552216097, 348.6043340808182, 364.1860441912327, 365.0781776015562, 5582.525485333752, 5582.86042848929, 5593.83218503445, 5615.354234263056, 5656.7737290508385, 5531.115021596545, 5541.722913854312, 5542.7782888684405, 5562.163296718672, 5569.941711074893, 3817.7709337439705, 4142.85500007499, 4264.466941632296, 4355.324924636687, 4408.735475871442, 4399.42807435033, 4418.469783625953, 4430.623397011242, 4432.778361081933, 4454.53227411122, 4402.449693788277, 4402.955970440286, 4434.312681534351, 4439.378487011821, 4449.421575195236, 4277.401163837066, 4368.868933931987, 4387.758673272969, 4422.292433210687, 4447.932496200905, 3898.7465814721954, 3899.660203877679, 3907.628775266345, 3911.5306163260307, 3917.099067214528, 5321.5210631043, 5369.463053694639, 5399.7030163341, 5408.783648654088, 5433.864153396196, 4943.612846248845, 5004.199328107486, 5036.647434679574, 5043.974780126113, 5069.493050694938, 5817.214676018725, 5817.505512031483, 5825.155352473867, 5826.766929322822, 5836.766529338822, 4330.848420305274, 4334.609885110355, 4335.176316499855, 4336.718113322624, 4350.216960947028, 5749.59752817303, 6005.609635373687, 6028.517718582503, 6061.51507879373, 6077.453029227391, 4252.277112890816, 4275.893102672396, 4281.422008028939, 4283.614474697292, 4286.785660717014, 4347.434923427563, 4363.192809330284, 4372.5352007077345, 4379.671524635665, 4381.255186618282, 4891.364122664102, 4938.827141050046, 4977.303177555145, 4987.1771157759285, 4990.90018199634, 5852.4440178183, 5856.619319744203, 5865.560082993792, 5884.205632239678, 5906.704664766745, 1429.8632587093286, 1429.9499517516838, 1438.4893362856244, 1438.7266419380285, 1439.4098419648103, 940.8682784410188, 989.8762654668167, 992.4591097851688, 1019.7501612104934, 1026.7689769801884, 5445.809396671098, 5489.58828087895, 5505.724713764376, 5531.695756733418, 5587.245721827582, 5811.198528456108, 5827.475527202488, 5836.365817571087, 5854.238948936696, 5866.472017518358, 5237.3453318335205, 5507.9449205507435, 5543.944560554342, 5573.442655734475, 5600.691961942132, 3063.7089476499696, 3067.4478593852873, 3074.8155110692983, 3076.8000079994727, 3100.875964961376, 5934.258217722785, 5958.314793798769, 6087.208662873798, 6087.873743357493, 6123.08153776937, 5853.88292234153, 5864.970675146597, 5870.767138900793, 5902.642392249721, 5951.821445356646, 6176.907346389808, 6190.938090619126, 6220.688965551704, 6248.218972628421, 6307.842303942438, 5967.9701601491715, 5990.910136348046, 6010.368911264254, 6066.0, 6086.543509236736, 5883.499902508334, 5885.705714714161, 5923.644581325134, 5932.911006334994, 5982.162497250301, 6298.811035668938, 6312.5581209314905, 6319.968400158154, 6384.904226436514, 6396.5373331266865, 4314.633256173261, 4354.542773008915, 4368.082702632356, 4371.650267978618, 4382.23310920594, 6009.964967691288, 6020.759169633166, 6022.909656355246, 6038.63768173911, 6061.757529698939, 5904.903759165434, 5906.557008224315, 5914.852128696817, 5936.28764548257, 5940.7919723348905, 5659.830205093854, 5839.649621022752, 5868.794592189253, 5882.441168089024, 5925.911111333247, 5839.35767065614, 5850.327212370632, 5859.765609375748, 5864.296284445723, 5882.852928676817, 5720.256366672473, 5851.795187168599, 5870.0, 5884.0, 5895.9115613266695, 5734.702546035963, 5738.540916726568, 5740.3685594585395, 5743.167240750151, 5761.5390768739235], "value": 4460.590484494911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.7213672735999, 745.3105877063718, 791.8020494876281, 836.4604829884723, 871.2724874729603, 14220.075695079813, 14799.18604476752, 14869.55391338259, 14922.701545969088, 14962.775558366606, 14215.644608884782, 14519.49181778638, 14522.636934076627, 14536.0, 14555.927220363883, 829.6266679993996, 834.3658819297348, 838.4591938199858, 844.8648216285395, 847.4152834544176, 840.9032961209448, 842.0989541190928, 843.0305149078547, 843.4559708987699, 843.6035063520136, 869.1395518436765, 873.4104479476359, 873.8121303919656, 877.1579283887476, 878.9868151977726, 864.6973559254274, 865.212656482601, 865.446114486729, 865.4850364033422, 873.3799002708084, 638.7285403703454, 644.5069521815815, 645.2805122288661, 645.893427584448, 647.1683886206202, 12901.935490322488, 12929.094963352569, 12976.870231297755, 12978.35108244584, 13021.0, 12538.122331436804, 12718.10973231874, 12770.80843787344, 12778.680532986657, 12885.033622478351, 11091.223614346998, 11104.833427498594, 11146.665600032013, 11181.385023823686, 11189.328640281608, 3614.765040272374, 3702.241040586673, 3704.2591481703766, 3764.1530655602546, 3816.427535869614, 60802.695986519786, 60978.0, 62526.37473625251, 62776.05835912465, 64766.352336476506, 9281.164695177331, 9444.763880903032, 9490.240780737524, 9506.90493095074, 9700.36947598418, 18528.629427411375, 18642.44072677822, 18655.90672046631, 18809.0, 18831.81168188328, 7817.452778305464, 8063.959680201679, 8090.676372945134, 8234.341252699769, 8247.628856701464, 4405.757683327448, 4512.52618475062, 4532.9320060199125, 4534.455865296186, 4565.748883811356, 3276.1973316537124, 3377.4427219508507, 3379.6113446953423, 3380.2056516718553, 3382.1713680148027, 582.1529674323849, 587.8589138606703, 596.4095545410099, 601.9969900150471, 603.4508597176548, 647.2136354329513, 668.5019660353069, 677.2448719677623, 682.9351211634887, 686.1354693086747, 9380.202682771904, 9502.097300756417, 9570.90429095714, 10016.679528989958, 10081.49592520371, 556.3324011186593, 629.2417636747708, 641.6759536434071, 662.2648859765657, 674.1236392689484, 4553.817847286072, 4625.32932724753, 4852.369192005017, 4855.883146876238, 4897.335669676944, 53831.0, 72423.91364129542, 89714.0, 89968.0, 90997.54501227583, 75732.0, 76820.61589692127, 78386.0, 79071.0, 79693.60153199197, 68981.3101868985, 69685.65157174182, 70576.88269351928, 70839.0, 71052.64473677598, 9354.485503297385, 9562.18721408688, 9718.805623887623, 9770.609175632895, 10038.447885366082, 44507.77746111378, 45551.31673024974, 45892.0, 46108.53891461043, 46862.76568617135, 59742.40257597368, 61131.69434152801, 62974.370256296854, 63096.0, 63473.68263158655, 13361.13152645075, 13499.46002159942, 13567.660808479866, 14095.154290742588, 14144.504942326968, 14215.928920355746, 14300.856991429953, 14543.673012317979, 14655.193964331638, 15050.698986020438, 13654.658633534242, 13817.101888377223, 13911.791323129959, 14065.085769424955, 14772.261386930826, 12780.808287875503, 13505.0, 13921.860781392461, 14419.85580144185, 14727.55817325482, 12765.8085128725, 13202.273874936971, 13475.124116932368, 13922.651933701738, 14166.150030998173, 11380.772384552429, 11531.365774882126, 11748.88251117478, 11844.76310473803, 12167.756644866877, 11549.595764148215, 12034.277943323428, 12097.647651894238, 12368.0, 12375.814362784746], "value": 7150.8844150750665, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1472.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 111.0, 112.0, 114.0, 110.0, 111.0, 113.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 128.0, 123.0, 156.0, 126.0, 128.0, 124.0, 122.0, 146.0, 123.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 165.0, 163.0, 162.0, 163.0, 161.0, 163.0, 162.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 102.0, 76.0, 75.0, 75.0, 75.0, 99.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 83.0, 83.0, 81.0, 94.0, 81.0, 83.0, 103.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 117.0, 117.0, 117.0, 119.0, 116.0, 119.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 149.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 87.0, 86.0, 85.0, 85.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 54.0, 52.0, 53.0, 50.0, 53.0, 51.0, 53.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 77.0, 76.0, 77.0, 76.0, 76.0, 75.0, 76.0, 75.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 128.0, 127.0, 131.0, 145.0, 133.0, 131.0, 177.0, 126.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 159.0, 159.0, 157.0, 158.0, 157.0, 163.0, 165.0, 156.0, 159.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 63.0, 64.0, 67.0, 62.0, 65.0, 62.0, 61.0], "value": 63.9, "unit": "score"}]}]} 17:31:02 INFO - Return code: 0 17:31:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:31:03 ERROR - # TBPL SUCCESS # 17:31:03 INFO - Running post-action listener: _resource_record_post_action 17:31:03 INFO - [mozharness: 2016-12-01 01:31:03.023417Z] Finished run-tests step (success) 17:31:03 INFO - Running post-run listener: _resource_record_post_run 17:31:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 354734080; Read time: 24; Write time: 232960 17:31:03 INFO - TinderboxPrint: CPU usage
13.3% 17:31:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 17:31:03 INFO - TinderboxPrint: I/O write bytes / time
354,734,080 / 232,960 17:31:03 INFO - TinderboxPrint: CPU idle
8,230.0 (86.7%) 17:31:03 INFO - TinderboxPrint: CPU user
1,207.5 (12.7%) 17:31:03 INFO - TinderboxPrint: Swap in / out
0 / 0 17:31:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109678592; Read time: 0; Write time: 93884 17:31:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 244723712; Read time: 0; Write time: 139072 17:31:03 INFO - Running post-run listener: _upload_blobber_files 17:31:03 INFO - Blob upload gear active. 17:31:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:31:03 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 17:31:03 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'] 17:31:03 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 17:31:04 INFO - (blobuploader) - INFO - Open directory for files ... 17:31:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:31:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:31:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:04 INFO - (blobuploader) - INFO - Done attempting. 17:31:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:31:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:08 INFO - (blobuploader) - INFO - Done attempting. 17:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:31:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:31:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:09 INFO - (blobuploader) - INFO - Done attempting. 17:31:09 INFO - (blobuploader) - INFO - Iteration through files over. 17:31:09 INFO - Return code: 0 17:31:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:31:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:31:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c543c4591e32ce139098e4d2bd639d03fa88e039f16e1c10362b757276294a3e2451f5aa312e678283182d094ceec32b42f583e12186543c06b89e8600fd355b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b049959fd6ba8391840b71bd3d3addb8d0707dbbdf07aad57dec0640d5943c133239e68f419834c51aa1d6b797bcc6f12ac4c602da1fa98a4461cf04098be5b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f7e8dc0fdc3426b47bf34da2730c5450043c3e74fc40b14734e867cb5e2440e26dc60d8b7b24d80bda5f36215f160904d96077e786406392fc96f5faf728495"} 17:31:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:31:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:31:09 INFO - Contents: 17:31:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c543c4591e32ce139098e4d2bd639d03fa88e039f16e1c10362b757276294a3e2451f5aa312e678283182d094ceec32b42f583e12186543c06b89e8600fd355b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b049959fd6ba8391840b71bd3d3addb8d0707dbbdf07aad57dec0640d5943c133239e68f419834c51aa1d6b797bcc6f12ac4c602da1fa98a4461cf04098be5b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f7e8dc0fdc3426b47bf34da2730c5450043c3e74fc40b14734e867cb5e2440e26dc60d8b7b24d80bda5f36215f160904d96077e786406392fc96f5faf728495"} 17:31:09 INFO - Running post-run listener: copy_logs_to_upload_dir 17:31:09 INFO - Copying logs to upload dir... 17:31:09 INFO - mkdir: /builds/slave/test/build/upload/logs 17:31:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.424764 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-30 17:31:08.894152) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 17:31:08.901366) ========= 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=41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c543c4591e32ce139098e4d2bd639d03fa88e039f16e1c10362b757276294a3e2451f5aa312e678283182d094ceec32b42f583e12186543c06b89e8600fd355b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b049959fd6ba8391840b71bd3d3addb8d0707dbbdf07aad57dec0640d5943c133239e68f419834c51aa1d6b797bcc6f12ac4c602da1fa98a4461cf04098be5b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f7e8dc0fdc3426b47bf34da2730c5450043c3e74fc40b14734e867cb5e2440e26dc60d8b7b24d80bda5f36215f160904d96077e786406392fc96f5faf728495"} build_url:https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011792 build_url: 'https://queue.taskcluster.net/v1/task/awltGK-WSiKIdmdQFjdKQg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c543c4591e32ce139098e4d2bd639d03fa88e039f16e1c10362b757276294a3e2451f5aa312e678283182d094ceec32b42f583e12186543c06b89e8600fd355b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b049959fd6ba8391840b71bd3d3addb8d0707dbbdf07aad57dec0640d5943c133239e68f419834c51aa1d6b797bcc6f12ac4c602da1fa98a4461cf04098be5b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f7e8dc0fdc3426b47bf34da2730c5450043c3e74fc40b14734e867cb5e2440e26dc60d8b7b24d80bda5f36215f160904d96077e786406392fc96f5faf728495"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 17:31:08.929803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 17:31:08.930159) ========= 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=41a7e32711b8e08598a63237000001d6-1480554632.538175-1771958145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 17:31:09.012695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 17:31:09.016125) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 17:31:09.016490) ========= ========= Total master_lag: 0.19 =========