builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1475561812.96 results: success (0) buildid: 20161003213045 builduid: 050004a692aa4a1bb3fafeb04fc291f8 revision: 625a597ea7e3557d18487cf1616eb599f8ba34a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:52.959098) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:52.960084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:52.960735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:52.973435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:52.974133) ========= 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=52faae308a556c440401f8e5000001e8-1475561813.17947-638106078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 23:16:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-10-03 23:16:53 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077594 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:53.069919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:53.070575) ========= 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=52faae308a556c440401f8e5000001e8-1475561813.17947-638106078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016264 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:53.121853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:53.122653) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 625a597ea7e3557d18487cf1616eb599f8ba34a2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 625a597ea7e3557d18487cf1616eb599f8ba34a2 --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=52faae308a556c440401f8e5000001e8-1475561813.17947-638106078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 23:16:53,927 truncating revision to first 12 chars 2016-10-03 23:16:53,927 Setting DEBUG logging. 2016-10-03 23:16:53,927 attempt 1/10 2016-10-03 23:16:53,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/625a597ea7e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 23:16:54,549 unpacking tar archive at: mozilla-inbound-625a597ea7e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.956039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:54.094240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:54.094609) ========= script_repo_revision: 625a597ea7e3557d18487cf1616eb599f8ba34a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:54.095067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:54.095373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 23:16:54.104316) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-03 23:16:54.104626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=52faae308a556c440401f8e5000001e8-1475561813.17947-638106078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:16:54 INFO - MultiFileLogger online at 20161003 23:16:54 in /builds/slave/test 23:16:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 23:16:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:16:55 INFO - {'append_to_log': False, 23:16:55 INFO - 'base_work_dir': '/builds/slave/test', 23:16:55 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 23:16:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:16:55 INFO - 'branch': 'Mozilla-Inbound', 23:16:55 INFO - 'buildbot_json_path': 'buildprops.json', 23:16:55 INFO - 'config_files': ('talos/linux_config.py',), 23:16:55 INFO - 'default_actions': ('clobber', 23:16:55 INFO - 'read-buildbot-config', 23:16:55 INFO - 'download-and-extract', 23:16:55 INFO - 'populate-webroot', 23:16:55 INFO - 'create-virtualenv', 23:16:55 INFO - 'install', 23:16:55 INFO - 'run-tests'), 23:16:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:16:55 INFO - 'download_minidump_stackwalk': True, 23:16:55 INFO - 'download_symbols': 'ondemand', 23:16:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:16:55 INFO - 'tooltool.py': '/tools/tooltool.py', 23:16:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:16:55 INFO - '/tools/misc-python/virtualenv.py')}, 23:16:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:16:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:16:55 INFO - 'installer_path': 'installer.exe', 23:16:55 INFO - 'log_level': 'info', 23:16:55 INFO - 'log_name': 'talos', 23:16:55 INFO - 'log_to_console': True, 23:16:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:16:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:16:55 INFO - 'opt_config_files': (), 23:16:55 INFO - 'pip_index': False, 23:16:55 INFO - 'sps_profile': False, 23:16:55 INFO - 'sps_profile_interval': 0, 23:16:55 INFO - 'suite': 'dromaeojs-e10s', 23:16:55 INFO - 'system_bits': '32', 23:16:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:16:55 INFO - 'title': 'talos-linux64-ix-056', 23:16:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:16:55 INFO - 'use_talos_json': True, 23:16:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:16:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:16:55 INFO - 'work_dir': 'build'} 23:16:55 INFO - [mozharness: 2016-10-04 06:16:55.009809Z] Running clobber step. 23:16:55 INFO - Running pre-action listener: _resource_record_pre_action 23:16:55 INFO - Running main action method: clobber 23:16:55 INFO - rmtree: /builds/slave/test/build 23:16:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:16:55 INFO - Running post-action listener: _resource_record_post_action 23:16:55 INFO - [mozharness: 2016-10-04 06:16:55.467890Z] Finished clobber step (success) 23:16:55 INFO - [mozharness: 2016-10-04 06:16:55.467989Z] Running read-buildbot-config step. 23:16:55 INFO - Running pre-action listener: _resource_record_pre_action 23:16:55 INFO - Running main action method: read_buildbot_config 23:16:55 INFO - Using buildbot properties: 23:16:55 INFO - { 23:16:55 INFO - "project": "", 23:16:55 INFO - "product": "firefox", 23:16:55 INFO - "script_repo_revision": "production", 23:16:55 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 23:16:55 INFO - "repository": "", 23:16:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 23:16:55 INFO - "buildid": "20161003213045", 23:16:55 INFO - "pgo_build": "True", 23:16:55 INFO - "basedir": "/builds/slave/test", 23:16:55 INFO - "buildnumber": 1479, 23:16:55 INFO - "slavename": "talos-linux64-ix-056", 23:16:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:16:55 INFO - "platform": "ubuntu64_hw", 23:16:55 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 23:16:55 INFO - "branch": "mozilla-inbound", 23:16:55 INFO - "repo_path": "integration/mozilla-inbound", 23:16:55 INFO - "revision": "625a597ea7e3557d18487cf1616eb599f8ba34a2", 23:16:55 INFO - "stage_platform": "linux64-pgo", 23:16:55 INFO - "builduid": "050004a692aa4a1bb3fafeb04fc291f8", 23:16:55 INFO - "slavebuilddir": "test" 23:16:55 INFO - } 23:16:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:16:55 INFO - Running post-action listener: _resource_record_post_action 23:16:55 INFO - [mozharness: 2016-10-04 06:16:55.470677Z] Finished read-buildbot-config step (success) 23:16:55 INFO - [mozharness: 2016-10-04 06:16:55.470765Z] Running download-and-extract step. 23:16:55 INFO - Running pre-action listener: _resource_record_pre_action 23:16:55 INFO - Running main action method: download_and_extract 23:16:55 INFO - mkdir: /builds/slave/test/build/tests 23:16: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')]} 23:16:55 INFO - trying https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:16:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:16:56 INFO - Downloaded 1361 bytes. 23:16:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:16:56 INFO - Using the following test package requirements: 23:16:56 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:16:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:16:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:56 INFO - u'jsshell-linux-x86_64.zip'], 23:16:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:16:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:16:56 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:16:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:16:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:16:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:16:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:16:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:16:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:16:56 INFO - Http code: 200 23:16:56 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 23:16:56 INFO - x-amz-cf-id: GVrJE4eN4iZKu3RnYwQRtpmhAkW2wuvCxQ7SMoCXv-894bPb8eql8w== 23:16:56 INFO - x-amz-version-id: SzYLsHHEALlygV6ggL55KULqWP163C.B 23:16:56 INFO - Expected file size: 21992701 23:16:56 INFO - Obtained file size: 21992701 23:17:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:17:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:17:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:17:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:17:01 INFO - Http code: 200 23:17:01 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 23:17:01 INFO - x-amz-cf-id: Bbi9HavSmqWo27OQu6WXi6PR5JnAIWRBFWOVdSOAnLFeKo87zyp6Tw== 23:17:01 INFO - x-amz-version-id: SzYLsHHEALlygV6ggL55KULqWP163C.B 23:17:01 INFO - Expected file size: 21992701 23:17:01 INFO - Obtained file size: 21992701 23:17:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:17:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:17:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:17:06 INFO - Http code: 200 23:17:06 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 23:17:06 INFO - x-amz-cf-id: LsFm0psX-E8ZO0a9hRF5iu6-FNhCGgm2PppAdqQ7Zqvg831jtyekOg== 23:17:06 INFO - x-amz-version-id: KsUa6fmB3bngoQiaLNX7nFq4m8ICKT7Y 23:17:06 INFO - Expected file size: 14408522 23:17:06 INFO - Obtained file size: 14408522 23:17: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')]} 23:17:07 INFO - trying https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:17:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:17:08 INFO - Downloaded 59687696 bytes. 23:17:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:17:08 INFO - mkdir: /builds/slave/test/properties 23:17:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:17:08 INFO - Writing to file /builds/slave/test/properties/build_url 23:17:08 INFO - Contents: 23:17:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:17:09 INFO - Running post-action listener: _resource_record_post_action 23:17:09 INFO - Running post-action listener: set_extra_try_arguments 23:17:09 INFO - [mozharness: 2016-10-04 06:17:09.016711Z] Finished download-and-extract step (success) 23:17:09 INFO - [mozharness: 2016-10-04 06:17:09.016966Z] Running populate-webroot step. 23:17:09 INFO - Running pre-action listener: _resource_record_pre_action 23:17:09 INFO - Running main action method: populate_webroot 23:17:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:17:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:17:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:17:09 INFO - '--tppagecycles', 23:17:09 INFO - '7'], 23:17:09 INFO - 'tests': ['tsvgm']}}, 23:17:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:17:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:17:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:17:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:17:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:09 INFO - 'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:17:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:17:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:09 INFO - 'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['damp', 'tps']}, 23:17:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:09 INFO - 'tests': ['damp', 'tps']}, 23:17:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['dromaeo_dom']}, 23:17:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:17:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['basic_compositor_video']}, 23:17:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:17:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['a11yr', 23:17:09 INFO - 'ts_paint', 23:17:09 INFO - 'tpaint', 23:17:09 INFO - 'sessionrestore', 23:17:09 INFO - 'sessionrestore_no_auto_restore', 23:17:09 INFO - 'tabpaint']}, 23:17:09 INFO - 'other-e10s': {'tests': ['a11yr', 23:17:09 INFO - 'ts_paint', 23:17:09 INFO - 'tpaint', 23:17:09 INFO - 'sessionrestore', 23:17:09 INFO - 'sessionrestore_no_auto_restore', 23:17:09 INFO - 'tabpaint']}, 23:17:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:17:09 INFO - 'ts_paint', 23:17:09 INFO - 'tpaint', 23:17:09 INFO - 'sessionrestore', 23:17:09 INFO - 'sessionrestore_no_auto_restore', 23:17:09 INFO - 'tabpaint']}, 23:17:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:17:09 INFO - 'ts_paint', 23:17:09 INFO - 'tpaint', 23:17:09 INFO - 'sessionrestore', 23:17:09 INFO - 'sessionrestore_no_auto_restore', 23:17:09 INFO - 'tabpaint']}, 23:17:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['a11yr', 23:17:09 INFO - 'ts_paint', 23:17:09 INFO - 'tpaint', 23:17:09 INFO - 'sessionrestore', 23:17:09 INFO - 'sessionrestore_no_auto_restore', 23:17:09 INFO - 'tabpaint']}, 23:17:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['a11yr', 23:17:09 INFO - 'ts_paint', 23:17:09 INFO - 'tpaint', 23:17:09 INFO - 'sessionrestore', 23:17:09 INFO - 'sessionrestore_no_auto_restore', 23:17:09 INFO - 'tabpaint']}, 23:17:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['tsvgx', 23:17:09 INFO - 'tsvgr_opacity', 23:17:09 INFO - 'tart', 23:17:09 INFO - 'tscrollx', 23:17:09 INFO - 'cart']}, 23:17:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:17:09 INFO - 'tsvgr_opacity', 23:17:09 INFO - 'tart', 23:17:09 INFO - 'tscrollx', 23:17:09 INFO - 'cart']}, 23:17:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:09 INFO - 'talos_options': ['--disable-e10s'], 23:17:09 INFO - 'tests': ['tp5o']}, 23:17:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:09 INFO - 'tests': ['tp5o']}, 23:17:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:09 INFO - 'talos_options': ['--disable-e10s', 23:17:09 INFO - '--xperf_path', 23:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:17:09 INFO - 'tests': ['tp5n']}, 23:17:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:17:09 INFO - 'talos_options': ['--xperf_path', 23:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:17:09 INFO - 'tests': ['tp5n']}}, 23:17:09 INFO - 'talos.zip': {'path': '', 23:17:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:17:09 INFO - Running post-action listener: _resource_record_post_action 23:17:09 INFO - [mozharness: 2016-10-04 06:17:09.035282Z] Finished populate-webroot step (success) 23:17:09 INFO - [mozharness: 2016-10-04 06:17:09.035371Z] Running create-virtualenv step. 23:17:09 INFO - Running pre-action listener: _resource_record_pre_action 23:17:09 INFO - Running main action method: create_virtualenv 23:17:09 INFO - Creating virtualenv /builds/slave/test/build/venv 23:17:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:17:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:17:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:17:09 INFO - Using real prefix '/usr' 23:17:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:17:09 INFO - Installing distribute.............................................................................................................................................................................................done. 23:17:11 INFO - Installing pip.................done. 23:17:11 INFO - Return code: 0 23:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:17:11 INFO - Reading from file tmpfile_stdout 23:17:11 INFO - Output received: 23:17:11 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) 23:17:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:17: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')]} 23:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17: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')]} 23:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17: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', 'pip>=1.5'] in /builds/slave/test/build 23:17: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 pip>=1.5 23:17:11 INFO - Using env: {'DISPLAY': ':0', 23:17:11 INFO - 'HOME': '/home/cltbld', 23:17:11 INFO - 'LANG': 'en_US.UTF-8', 23:17:11 INFO - 'LANGUAGE': 'en_US:en', 23:17:11 INFO - 'LOGNAME': 'cltbld', 23:17:11 INFO - 'MAIL': '/var/mail/cltbld', 23:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:11 INFO - 'MOZ_NO_REMOTE': '1', 23:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:11 INFO - 'NO_EM_RESTART': '1', 23:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:11 INFO - 'PWD': '/builds/slave/test', 23:17:11 INFO - 'SHELL': '/bin/bash', 23:17:11 INFO - 'SHLVL': '1', 23:17:11 INFO - 'TERM': 'linux', 23:17:11 INFO - 'TMOUT': '86400', 23:17:11 INFO - 'USER': 'cltbld', 23:17:11 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:11 INFO - '_': '/tools/buildbot/bin/python'} 23:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:17:12 INFO - Cleaning up... 23:17:12 INFO - Return code: 0 23:17:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:17:12 INFO - Using env: {'DISPLAY': ':0', 23:17:12 INFO - 'HOME': '/home/cltbld', 23:17:12 INFO - 'LANG': 'en_US.UTF-8', 23:17:12 INFO - 'LANGUAGE': 'en_US:en', 23:17:12 INFO - 'LOGNAME': 'cltbld', 23:17:12 INFO - 'MAIL': '/var/mail/cltbld', 23:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:12 INFO - 'MOZ_NO_REMOTE': '1', 23:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:12 INFO - 'NO_EM_RESTART': '1', 23:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:12 INFO - 'PWD': '/builds/slave/test', 23:17:12 INFO - 'SHELL': '/bin/bash', 23:17:12 INFO - 'SHLVL': '1', 23:17:12 INFO - 'TERM': 'linux', 23:17:12 INFO - 'TMOUT': '86400', 23:17:12 INFO - 'USER': 'cltbld', 23:17:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:12 INFO - '_': '/tools/buildbot/bin/python'} 23:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:12 INFO - Downloading/unpacking psutil>=3.1.1 23:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:17:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:17:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:17:14 INFO - Installing collected packages: psutil 23:17:14 INFO - Running setup.py install for psutil 23:17:14 INFO - building 'psutil._psutil_linux' extension 23:17:14 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 23:17:14 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 23:17:14 INFO - building 'psutil._psutil_posix' extension 23:17:14 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 23:17:14 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 23:17:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:17:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:17:14 INFO - Successfully installed psutil 23:17:14 INFO - Cleaning up... 23:17:14 INFO - Return code: 0 23:17:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:17:14 INFO - Using env: {'DISPLAY': ':0', 23:17:14 INFO - 'HOME': '/home/cltbld', 23:17:14 INFO - 'LANG': 'en_US.UTF-8', 23:17:14 INFO - 'LANGUAGE': 'en_US:en', 23:17:14 INFO - 'LOGNAME': 'cltbld', 23:17:14 INFO - 'MAIL': '/var/mail/cltbld', 23:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:14 INFO - 'MOZ_NO_REMOTE': '1', 23:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:14 INFO - 'NO_EM_RESTART': '1', 23:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:14 INFO - 'PWD': '/builds/slave/test', 23:17:14 INFO - 'SHELL': '/bin/bash', 23:17:14 INFO - 'SHLVL': '1', 23:17:14 INFO - 'TERM': 'linux', 23:17:14 INFO - 'TMOUT': '86400', 23:17:14 INFO - 'USER': 'cltbld', 23:17:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:14 INFO - '_': '/tools/buildbot/bin/python'} 23:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:17:17 INFO - Installing collected packages: mozsystemmonitor 23:17:17 INFO - Running setup.py install for mozsystemmonitor 23:17:17 INFO - Successfully installed mozsystemmonitor 23:17:17 INFO - Cleaning up... 23:17:17 INFO - Return code: 0 23:17:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:17:17 INFO - Using env: {'DISPLAY': ':0', 23:17:17 INFO - 'HOME': '/home/cltbld', 23:17:17 INFO - 'LANG': 'en_US.UTF-8', 23:17:17 INFO - 'LANGUAGE': 'en_US:en', 23:17:17 INFO - 'LOGNAME': 'cltbld', 23:17:17 INFO - 'MAIL': '/var/mail/cltbld', 23:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:17 INFO - 'MOZ_NO_REMOTE': '1', 23:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:17 INFO - 'NO_EM_RESTART': '1', 23:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:17 INFO - 'PWD': '/builds/slave/test', 23:17:17 INFO - 'SHELL': '/bin/bash', 23:17:17 INFO - 'SHLVL': '1', 23:17:17 INFO - 'TERM': 'linux', 23:17:17 INFO - 'TMOUT': '86400', 23:17:17 INFO - 'USER': 'cltbld', 23:17:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:17 INFO - '_': '/tools/buildbot/bin/python'} 23:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:17 INFO - Downloading/unpacking jsonschema==2.5.1 23:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:17 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 23:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:17:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:17:19 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 23:17:19 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 23:17:19 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 23:17:19 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 23:17:19 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 23:17:19 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 23:17:19 INFO - Downloading functools32-3.2.3-2.tar.gz 23:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:17:19 INFO - warning: no files found matching '*.txt' 23:17:19 INFO - no previously-included directories found matching 'build' 23:17:19 INFO - no previously-included directories found matching 'dist' 23:17:19 INFO - no previously-included directories found matching '.git*' 23:17:19 INFO - Installing collected packages: jsonschema, functools32 23:17:19 INFO - Running setup.py install for functools32 23:17:19 INFO - warning: no files found matching '*.txt' 23:17:19 INFO - no previously-included directories found matching 'build' 23:17:19 INFO - no previously-included directories found matching 'dist' 23:17:19 INFO - no previously-included directories found matching '.git*' 23:17:19 INFO - Successfully installed jsonschema functools32 23:17:19 INFO - Cleaning up... 23:17:19 INFO - Return code: 0 23:17:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:17:19 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')]} 23:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:19 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')]} 23:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:19 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 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17:19 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 23:17:19 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 23:17:19 INFO - Using env: {'DISPLAY': ':0', 23:17:19 INFO - 'HOME': '/home/cltbld', 23:17:19 INFO - 'LANG': 'en_US.UTF-8', 23:17:19 INFO - 'LANGUAGE': 'en_US:en', 23:17:19 INFO - 'LOGNAME': 'cltbld', 23:17:19 INFO - 'MAIL': '/var/mail/cltbld', 23:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:19 INFO - 'MOZ_NO_REMOTE': '1', 23:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:19 INFO - 'NO_EM_RESTART': '1', 23:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:19 INFO - 'PWD': '/builds/slave/test', 23:17:19 INFO - 'SHELL': '/bin/bash', 23:17:19 INFO - 'SHLVL': '1', 23:17:19 INFO - 'TERM': 'linux', 23:17:19 INFO - 'TMOUT': '86400', 23:17:19 INFO - 'USER': 'cltbld', 23:17:19 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:19 INFO - '_': '/tools/buildbot/bin/python'} 23:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:17:19 INFO - Cleaning up... 23:17:19 INFO - Return code: 0 23:17:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:17:19 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')]} 23:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:19 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')]} 23:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:19 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 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17:19 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 23:17:19 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 23:17:19 INFO - Using env: {'DISPLAY': ':0', 23:17:19 INFO - 'HOME': '/home/cltbld', 23:17:19 INFO - 'LANG': 'en_US.UTF-8', 23:17:19 INFO - 'LANGUAGE': 'en_US:en', 23:17:19 INFO - 'LOGNAME': 'cltbld', 23:17:19 INFO - 'MAIL': '/var/mail/cltbld', 23:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:19 INFO - 'MOZ_NO_REMOTE': '1', 23:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:19 INFO - 'NO_EM_RESTART': '1', 23:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:19 INFO - 'PWD': '/builds/slave/test', 23:17:19 INFO - 'SHELL': '/bin/bash', 23:17:19 INFO - 'SHLVL': '1', 23:17:19 INFO - 'TERM': 'linux', 23:17:19 INFO - 'TMOUT': '86400', 23:17:19 INFO - 'USER': 'cltbld', 23:17:19 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:19 INFO - '_': '/tools/buildbot/bin/python'} 23:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:20 INFO - Downloading/unpacking blobuploader==1.2.4 23:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:22 INFO - Downloading blobuploader-1.2.4.tar.gz 23:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:17:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:17:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:22 INFO - Downloading docopt-0.6.1.tar.gz 23:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:17:22 INFO - Installing collected packages: blobuploader, requests, docopt 23:17:22 INFO - Running setup.py install for blobuploader 23:17:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:17:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:17:22 INFO - Running setup.py install for requests 23:17:23 INFO - Running setup.py install for docopt 23:17:23 INFO - Successfully installed blobuploader requests docopt 23:17:23 INFO - Cleaning up... 23:17:23 INFO - Return code: 0 23:17:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:23 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 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17:23 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 23:17:23 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 23:17:23 INFO - Using env: {'DISPLAY': ':0', 23:17:23 INFO - 'HOME': '/home/cltbld', 23:17:23 INFO - 'LANG': 'en_US.UTF-8', 23:17:23 INFO - 'LANGUAGE': 'en_US:en', 23:17:23 INFO - 'LOGNAME': 'cltbld', 23:17:23 INFO - 'MAIL': '/var/mail/cltbld', 23:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:23 INFO - 'MOZ_NO_REMOTE': '1', 23:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:23 INFO - 'NO_EM_RESTART': '1', 23:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:23 INFO - 'PWD': '/builds/slave/test', 23:17:23 INFO - 'SHELL': '/bin/bash', 23:17:23 INFO - 'SHLVL': '1', 23:17:23 INFO - 'TERM': 'linux', 23:17:23 INFO - 'TMOUT': '86400', 23:17:23 INFO - 'USER': 'cltbld', 23:17:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:23 INFO - '_': '/tools/buildbot/bin/python'} 23:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:17:23 INFO - Running setup.py (path:/tmp/pip-GNdPvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:17:23 INFO - Running setup.py (path:/tmp/pip-ehuVda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:17:23 INFO - Running setup.py (path:/tmp/pip-cX5xbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:17:23 INFO - Running setup.py (path:/tmp/pip-9ASOiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:17:23 INFO - Running setup.py (path:/tmp/pip-pKpGEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:17:24 INFO - Running setup.py (path:/tmp/pip-ieYTX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:17:24 INFO - Running setup.py (path:/tmp/pip-WYoYlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:17:24 INFO - Running setup.py (path:/tmp/pip-RI97Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:17:24 INFO - Running setup.py (path:/tmp/pip-Qayi5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:17:24 INFO - Running setup.py (path:/tmp/pip-I3mBl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:17:24 INFO - Running setup.py (path:/tmp/pip-BPShgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:17:24 INFO - Running setup.py (path:/tmp/pip-EP8GPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:24 INFO - Running setup.py (path:/tmp/pip-HS20sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:24 INFO - Running setup.py (path:/tmp/pip-xSDzmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:24 INFO - Running setup.py (path:/tmp/pip-c_98WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:24 INFO - Running setup.py (path:/tmp/pip-WpfX5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:24 INFO - Running setup.py (path:/tmp/pip-vYkf5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:17:24 INFO - Running setup.py install for manifestparser 23:17:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Running setup.py install for mozcrash 23:17:25 INFO - Running setup.py install for mozdebug 23:17:25 INFO - Running setup.py install for mozdevice 23:17:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Running setup.py install for mozfile 23:17:25 INFO - Running setup.py install for mozhttpd 23:17:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Running setup.py install for mozinfo 23:17:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Running setup.py install for mozInstall 23:17:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Running setup.py install for mozleak 23:17:25 INFO - Running setup.py install for mozlog 23:17:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:17:25 INFO - Running setup.py install for moznetwork 23:17:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:17:26 INFO - Running setup.py install for mozprocess 23:17:26 INFO - Running setup.py install for mozprofile 23:17:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:17:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:17:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:17:26 INFO - Running setup.py install for mozrunner 23:17:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:17:26 INFO - Running setup.py install for mozscreenshot 23:17:26 INFO - Running setup.py install for moztest 23:17:26 INFO - Running setup.py install for mozversion 23:17:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:17:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:17:26 INFO - Cleaning up... 23:17:26 INFO - Return code: 0 23:17:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:26 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 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17:26 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 23:17:26 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 23:17:26 INFO - Using env: {'DISPLAY': ':0', 23:17:26 INFO - 'HOME': '/home/cltbld', 23:17:26 INFO - 'LANG': 'en_US.UTF-8', 23:17:26 INFO - 'LANGUAGE': 'en_US:en', 23:17:26 INFO - 'LOGNAME': 'cltbld', 23:17:26 INFO - 'MAIL': '/var/mail/cltbld', 23:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:26 INFO - 'MOZ_NO_REMOTE': '1', 23:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:26 INFO - 'NO_EM_RESTART': '1', 23:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:26 INFO - 'PWD': '/builds/slave/test', 23:17:26 INFO - 'SHELL': '/bin/bash', 23:17:26 INFO - 'SHLVL': '1', 23:17:26 INFO - 'TERM': 'linux', 23:17:26 INFO - 'TMOUT': '86400', 23:17:26 INFO - 'USER': 'cltbld', 23:17:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:26 INFO - '_': '/tools/buildbot/bin/python'} 23:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:17:26 INFO - Running setup.py (path:/tmp/pip-7zYAdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:17:27 INFO - Running setup.py (path:/tmp/pip-AlfiNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:17:27 INFO - Running setup.py (path:/tmp/pip-cHFgwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:17:27 INFO - Running setup.py (path:/tmp/pip-fkJOCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:17:27 INFO - Running setup.py (path:/tmp/pip-_e6yQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:17:27 INFO - Running setup.py (path:/tmp/pip-lpgMXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:17:27 INFO - Running setup.py (path:/tmp/pip-n66wiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:17:27 INFO - Running setup.py (path:/tmp/pip-yTRwoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:17:27 INFO - Running setup.py (path:/tmp/pip-WH4j4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:17:27 INFO - Running setup.py (path:/tmp/pip-Vr795Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:17:27 INFO - Running setup.py (path:/tmp/pip-tui0qU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:17:27 INFO - Running setup.py (path:/tmp/pip-GSHTAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:27 INFO - Running setup.py (path:/tmp/pip-TMyEca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:27 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)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:27 INFO - Running setup.py (path:/tmp/pip-ELCPzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:27 INFO - Running setup.py (path:/tmp/pip-X6B1eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:28 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)) 23:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:28 INFO - Running setup.py (path:/tmp/pip-f_KFzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:28 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)) 23:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:28 INFO - Running setup.py (path:/tmp/pip-0ZPdPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:28 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)) 23:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:28 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)) 23:17:28 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)) 23:17:28 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)) 23:17:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:17:28 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 23:17:28 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 23:17:28 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 23:17:28 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 23:17:28 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 23:17:28 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 23:17:30 INFO - Downloading blessings-1.6.tar.gz 23:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:17:30 INFO - Installing collected packages: blessings 23:17:30 INFO - Running setup.py install for blessings 23:17:30 INFO - Successfully installed blessings 23:17:30 INFO - Cleaning up... 23:17:30 INFO - Return code: 0 23:17:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:30 INFO - Reading from file tmpfile_stdout 23:17:30 INFO - Current package versions: 23:17:30 INFO - argparse == 1.2.1 23:17:30 INFO - blessings == 1.6 23:17:30 INFO - blobuploader == 1.2.4 23:17:30 INFO - docopt == 0.6.1 23:17:30 INFO - functools32 == 3.2.3-2 23:17:30 INFO - jsonschema == 2.5.1 23:17:30 INFO - manifestparser == 1.1 23:17:30 INFO - mozInstall == 1.12 23:17:30 INFO - mozcrash == 0.17 23:17:30 INFO - mozdebug == 0.1 23:17:30 INFO - mozdevice == 0.48 23:17:30 INFO - mozfile == 1.2 23:17:30 INFO - mozhttpd == 0.7 23:17:30 INFO - mozinfo == 0.9 23:17:30 INFO - mozleak == 0.1 23:17:30 INFO - mozlog == 3.4 23:17:30 INFO - moznetwork == 0.27 23:17:30 INFO - mozprocess == 0.23 23:17:30 INFO - mozprofile == 0.28 23:17:30 INFO - mozrunner == 6.12 23:17:30 INFO - mozscreenshot == 0.1 23:17:30 INFO - mozsystemmonitor == 0.3 23:17:30 INFO - moztest == 0.7 23:17:30 INFO - mozversion == 1.4 23:17:30 INFO - psutil == 3.1.1 23:17:30 INFO - requests == 1.2.3 23:17:30 INFO - wsgiref == 0.1.2 23:17:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:30 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')]} 23:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:30 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')]} 23:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:30 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 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17:30 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 23:17:30 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 23:17:30 INFO - Using env: {'DISPLAY': ':0', 23:17:30 INFO - 'HOME': '/home/cltbld', 23:17:30 INFO - 'LANG': 'en_US.UTF-8', 23:17:30 INFO - 'LANGUAGE': 'en_US:en', 23:17:30 INFO - 'LOGNAME': 'cltbld', 23:17:30 INFO - 'MAIL': '/var/mail/cltbld', 23:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:30 INFO - 'MOZ_NO_REMOTE': '1', 23:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:30 INFO - 'NO_EM_RESTART': '1', 23:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:30 INFO - 'PWD': '/builds/slave/test', 23:17:30 INFO - 'SHELL': '/bin/bash', 23:17:30 INFO - 'SHLVL': '1', 23:17:30 INFO - 'TERM': 'linux', 23:17:30 INFO - 'TMOUT': '86400', 23:17:30 INFO - 'USER': 'cltbld', 23:17:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:30 INFO - '_': '/tools/buildbot/bin/python'} 23:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:30 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)) 23:17:30 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)) 23:17:30 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)) 23:17:30 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)) 23:17:30 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)) 23:17:30 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)) 23:17:30 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)) 23:17:30 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)) 23:17:30 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)) 23:17:30 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)) 23:17:30 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)) 23:17:30 INFO - Cleaning up... 23:17:30 INFO - Return code: 0 23:17:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:17:30 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')]} 23:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:30 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')]} 23:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:30 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 0x7f972e137f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', '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 23:17:30 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 23:17:30 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 23:17:30 INFO - Using env: {'DISPLAY': ':0', 23:17:30 INFO - 'HOME': '/home/cltbld', 23:17:30 INFO - 'LANG': 'en_US.UTF-8', 23:17:30 INFO - 'LANGUAGE': 'en_US:en', 23:17:30 INFO - 'LOGNAME': 'cltbld', 23:17:30 INFO - 'MAIL': '/var/mail/cltbld', 23:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:30 INFO - 'MOZ_NO_REMOTE': '1', 23:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:30 INFO - 'NO_EM_RESTART': '1', 23:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:30 INFO - 'PWD': '/builds/slave/test', 23:17:30 INFO - 'SHELL': '/bin/bash', 23:17:30 INFO - 'SHLVL': '1', 23:17:30 INFO - 'TERM': 'linux', 23:17:30 INFO - 'TMOUT': '86400', 23:17:30 INFO - 'USER': 'cltbld', 23:17:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:30 INFO - '_': '/tools/buildbot/bin/python'} 23:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:17:31 INFO - Cleaning up... 23:17:31 INFO - Return code: 0 23:17:31 INFO - Running post-action listener: _resource_record_post_action 23:17:31 INFO - Running post-action listener: _start_resource_monitoring 23:17:31 INFO - Starting resource monitoring. 23:17:31 INFO - [mozharness: 2016-10-04 06:17:31.072469Z] Finished create-virtualenv step (success) 23:17:31 INFO - [mozharness: 2016-10-04 06:17:31.072910Z] Running install step. 23:17:31 INFO - Running pre-action listener: _resource_record_pre_action 23:17:31 INFO - Running main action method: install 23:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:31 INFO - Reading from file tmpfile_stdout 23:17:31 INFO - Detecting whether we're running mozinstall >=1.0... 23:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:17:31 INFO - Reading from file tmpfile_stdout 23:17:31 INFO - Output received: 23:17:31 INFO - Usage: mozinstall [options] installer 23:17:31 INFO - Options: 23:17:31 INFO - -h, --help show this help message and exit 23:17:31 INFO - -d DEST, --destination=DEST 23:17:31 INFO - Directory to install application into. [default: 23:17:31 INFO - "/builds/slave/test"] 23:17:31 INFO - --app=APP Application being installed. [default: firefox] 23:17:31 INFO - mkdir: /builds/slave/test/build/application 23:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:17:48 INFO - Reading from file tmpfile_stdout 23:17:48 INFO - Output received: 23:17:48 INFO - /builds/slave/test/build/application/firefox/firefox 23:17:48 INFO - Running post-action listener: _resource_record_post_action 23:17:48 INFO - [mozharness: 2016-10-04 06:17:48.383099Z] Finished install step (success) 23:17:48 INFO - [mozharness: 2016-10-04 06:17:48.383342Z] Running run-tests step. 23:17:48 INFO - Running pre-action listener: _resource_record_pre_action 23:17:48 INFO - Running main action method: run_tests 23:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:17:48 INFO - Python 2.7.3 23:17:48 INFO - Return code: 0 23:17:48 INFO - grabbing minidump binary from tooltool 23:17:48 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')]} 23:17:48 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 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:17:48 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 23:17:48 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 23:17:48 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 23:17:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:17:48 INFO - Return code: 0 23:17:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:17:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:17:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:17:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:17:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 23:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 23:17:48 INFO - Using env: {'DISPLAY': ':0', 23:17:48 INFO - 'HOME': '/home/cltbld', 23:17:48 INFO - 'LANG': 'en_US.UTF-8', 23:17:48 INFO - 'LANGUAGE': 'en_US:en', 23:17:48 INFO - 'LOGNAME': 'cltbld', 23:17:48 INFO - 'MAIL': '/var/mail/cltbld', 23:17:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:17:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:48 INFO - 'MOZ_NO_REMOTE': '1', 23:17:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:48 INFO - 'NO_EM_RESTART': '1', 23:17:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:48 INFO - 'PWD': '/builds/slave/test', 23:17:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:17:48 INFO - 'SHELL': '/bin/bash', 23:17:48 INFO - 'SHLVL': '1', 23:17:48 INFO - 'TERM': 'linux', 23:17:48 INFO - 'TMOUT': '86400', 23:17:48 INFO - 'USER': 'cltbld', 23:17:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475561813.17947-638106078', 23:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:48 INFO - '_': '/tools/buildbot/bin/python'} 23:17:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 23:17:48 INFO - mozversion application_buildid: 20161003213045 23:17:48 INFO - mozversion application_changeset: 625a597ea7e3557d18487cf1616eb599f8ba34a2 23:17:48 INFO - mozversion application_display_name: Nightly 23:17:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:17:48 INFO - mozversion application_name: Firefox 23:17:48 INFO - mozversion application_remotingname: firefox 23:17:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:17:48 INFO - mozversion application_vendor: Mozilla 23:17:48 INFO - mozversion application_version: 52.0a1 23:17:48 INFO - mozversion platform_buildid: 20161003213045 23:17:48 INFO - mozversion platform_changeset: 625a597ea7e3557d18487cf1616eb599f8ba34a2 23:17:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:17:48 INFO - mozversion platform_version: 52.0a1 23:17:48 INFO - using testdate: 1475561868 23:17:48 INFO - actual date: 1475561868 23:17:48 INFO - starting webserver on 'localhost:43923' 23:17:48 INFO - SUITE-START | Running 2 tests 23:17:48 INFO - TEST-START | dromaeo_css 23:17:48 INFO - operating with platform_type : linux_ 23:17:48 INFO - Initialising browser for dromaeo_css test... 23:17:48 INFO - TEST-INFO | started process 30128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphFdGv9/profile http://localhost:43923/getInfo.html) 23:17:53 INFO - PROCESS | 30128 | __metrics Screen width/height:1600/1200 23:17:53 INFO - PROCESS | 30128 | colorDepth:24 23:17:53 INFO - PROCESS | 30128 | Browser inner width/height: 1024/697 23:17:53 INFO - PROCESS | 30128 | __metrics 23:17:54 ERROR - PROCESS | 30128 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 23:17:55 INFO - TEST-INFO | 30128: exit 0 23:17:55 INFO - Browser initialized. 23:17:55 INFO - Running cycle 1/1 for dromaeo_css test... 23:17:55 INFO - TEST-INFO | started process 30250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphFdGv9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:07 INFO - PROCESS | 30250 | RSS: Main: 184852480 23:18:07 INFO - PROCESS | 30250 | 23:18:56 INFO - PROCESS | 30250 | 1475561936993 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] 23:21:07 INFO - PROCESS | 30250 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43923/tests/dromaeo/cssquery-ext.html) 23:21:08 INFO - PROCESS | 30250 | RSS: Main: 200499200 23:21:08 INFO - PROCESS | 30250 | 23:24:11 INFO - PROCESS | 30250 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-ext.html (next: http://localhost:43923/tests/dromaeo/cssquery-jquery.html) 23:24:11 INFO - PROCESS | 30250 | RSS: Main: 197828608 23:24:11 INFO - PROCESS | 30250 | 23:27:13 INFO - PROCESS | 30250 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43923/tests/dromaeo/cssquery-mootools.html) 23:27:14 INFO - PROCESS | 30250 | RSS: Main: 199233536 23:27:14 INFO - PROCESS | 30250 | 23:30:15 INFO - PROCESS | 30250 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43923/tests/dromaeo/cssquery-prototype.html) 23:30:16 INFO - PROCESS | 30250 | RSS: Main: 195493888 23:30:16 INFO - PROCESS | 30250 | 23:33:19 INFO - PROCESS | 30250 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43923/tests/dromaeo/cssquery-yui.html) 23:33:19 INFO - PROCESS | 30250 | RSS: Main: 199106560 23:33:19 INFO - PROCESS | 30250 | 23:36:22 INFO - PROCESS | 30250 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-yui.html (next: http://localhost:43923/tests/dromaeo/cssquery-dojo.html) 23:36:22 INFO - PROCESS | 30250 | RSS: Main: 199786496 23:36:22 INFO - PROCESS | 30250 | 23:36:22 INFO - PROCESS | 30250 | __start_tp_report 23:36:22 INFO - PROCESS | 30250 | _x_x_mozilla_page_load 23:36:22 INFO - PROCESS | 30250 | _x_x_mozilla_page_load_details 23:36:22 INFO - PROCESS | 30250 | |i|pagename|runs| 23:36:22 INFO - PROCESS | 30250 | |0;dojo.html;2995.16135482065;3057.740092092172;3073.277779721765;3074.477338852394;3089.6755840636733;5191.688498690081;5244.947550524494;5310.893782124355;5361.088614935461;5364.490373414525;5208.713520756357;5208.791648334071;5267.209918512225;5311.57507399408;5325.254464374981;4734.763261836912;4826.806927722887;4839.814245509855;4843.297721830332;4867.610591152717;4879.463259041502;4924.532169443897;4929.580985616209;4955.578775804061;4991.500849915015;4800.735959522225;4839.153148199051;4847.975760121194;4854.587360074398;4917.434495033063;4826.638002149853;4833.130036593412;4853.611711063107;4906.852794416173;4919.877003074916;4777.617790576745;4813.927791083137;4823.5176482351835;4839.685420447695;4882.2432522959;5153.587712982952;5205.063088644042;5221.895562088775;5261.1319132343115;5336.30628018359;5586.776528938837;5604.747786349624;5643.351014633328;5666.490015898589;5683.5169010634145;5717.313922329347;5758.596898217126;5780.653160810365;5789.16057171712;5790.276215473066;5227.137522308776;5254.133068043807;5378.919316210221;5392.352917649907;5393.460653934575;5680.062789639664;5737.08206686928;5738.081906894877;5740.0815869460685;5805.303363596396;5511.862203444946;5526.253955715927;5526.336839579196;5542.8337149885565;5544.972275138679;5539.750711218005;5566.4990150886615;5600.4399560044485;5640.012997725382;5695.943040569624;5673.886522269531;5678.886422271614;5684.033714268584;5688.687122208235;5700.4299570043495;5696.971515142398;5698.116791897262;5717.342505611825;5718.714064296852;5726.341470730919;4307.612314891612;4328.458942632171;4357.629601483846;4413.668974826836;4429.7785110744335;3908.6091390861257;3931.0368959604507;3952.782596957195;3990.780507072139;4005.178938317638;5378.838634840961;5384.326959130109;5388.568914486832;5429.809956651498;5430.8099216527235;5469.507744302952;5533.3083364579425;5742.196092547047;5743.798967036134;5752.626079304831;5333.759980800874;5358.142697168512;5366.543843773245;5375.784968601212;5436.972815135978;4904.435989861212;4940.740111271674;4943.777530011158;4958.057968985881;4999.950000499948;5679.204911312502;5847.473727364558;5859.5019423349495;5859.853503662443;5872.618279811884;5551.139573366135;5606.887862242814;5626.718664066862;5653.604247702786;5678.488935995781;5817.127430885401;5818.33089194748;5823.621464604787;5825.475707186204;5829.562782791223;5501.669899806025;5536.0865457200725;5558.72206389687;5575.553955683455;5633.183188437735;5705.34388545306;5742.684152371659;5793.159991801081;5813.651180929158;5818.214541036906;5595.944040559705;5598.188262701967;5599.496045355938;5600.971995139998;5608.4111168326735;5431.646942948696;5442.238086667949;5526.889462210653;5588;5589.580781441489;5294.655847369909;5390.541803946551;5411.594130440154;5425.810096646598;5463.426340234377;5493.176023596492;5502.0921547945745;5504.7522861470525;5511.53151982086;5519.530839878656;5326.547243484192;5328.360596728262;5354.464553544614;5377.623566350318;5412.972935135299 23:36:22 INFO - PROCESS | 30250 | |1;ext.html;532.4675324675325;547.4197350808143;549.4560385218633;550.7796881247504;550.8347495751271;41194.58805411945;42905.35641965369;42973.14053718924;46618.76690616542;47196;44195.33706994398;44836.3274550882;44864.327035094415;45208.77395613026;45489.0902181957;8882.866756998634;8994.415363001384;9034.774130646754;9051.456912585267;9072.455652660861;8815.206631403173;8844.38089333747;8885.822283554326;8894.288456923463;8906.910930890705;8940.64237430502;8950.283977281835;8973.327000474957;8975.416597921147;9017.36878418511;8890.51102189376;8933.240674542672;8963.282937365027;8975.371723979324;8986.955065224698;8844.690435834715;8845.734627961172;8857.468551886843;8861.822763544693;8898.4660920345;41661;42357.36463953043;42613.147737045394;42672.78663606662;42677.78661106706;3439.5872495300473;3452.7755695879937;3585.515955346021;3738.8504459821575;4007.6192761687594;31200.687993120006;31209.21976950572;31299.04184571818;31837.363252734816;31963.200919976953;3825.7513261637905;3920.882373528799;3940;4020.537638171589;4353.760543170124;346985;349956;350282;351277;352293.6697215585;58329.70835145882;58745.70627146922;58842.41157588369;58912.410875891546;59216.70391648014;62497.37502625006;62702;63008.68495657584;63272.36727632757;63429.68285158544;16101.597460063593;16293.67412651764;16313.918430407772;16329;16340.75488867668;12558.81161782574;12662.873371266354;12676.492940282285;12699.365031748375;12760.425780839885;17542.733327983347;18709.719354209425;18837.340693075676;18968.715469267972;18971.43085707431;6980.743466176137;7191.208967013625;7219.880918457648;7361.705531778669;7424.146223184295;894.3069121430943;997.5760301871676;1028.4292217819182;1032.4528000159928;1042.3797840285017;31728.524072138935;31928;31954.84022579872;32093;32168.06991580513;1046.6859942017363;1052.9789404212027;1060.7666313411037;1082.1288862465633;1133.1614605192099;15236.771448428282;16275.59311017234;16617;16717;16967.575810604834;511256;825948;842053;842563;842942;55250.85618578542;55542;55588.444115559134;55810.44189558134;55937.16094258589;1316.7432350691522;1342.4026308292716;1348.1506650810122;1356.8439629442544;1361.700425906299;29131.563026554195;30431.695683042886;31180.844095779375;31181.376372472878;31181.688183118786;47547.524524754306;48059.75970120127;48079.278810817166;48105.75947120242;48139;372872;375921;376551;376806;376943;27622;27869.442611148068;27973.300667483476;27995.940588614943;28136.327048930318;43758;43839.56160438355;43880.78059609682;44099.236030558415;45475.31787023131;37463.81268093751;38277.277522510994;38374.424383634825;38513.229735405694;38953.220935581696;38074.23851523009;38201;38696;39420.80289598534;39700.404493933194;36569.817150915136;36620.63379366172;37373.4393984085;37881.62118378781;38179.23641527209;32410.83794581012;36060.4590931131;38915.6108438912;39242.80378598089;40160.799196003834;27245.003049664916;27735.861320693268;28020.859895700392;28144.577831332135;28307.575386368808 23:36:22 INFO - PROCESS | 30250 | |2;jquery.html;393.5788706084489;398.1042654028432;398.7439565369087;399.71021009767924;428.5243379848368;17806.643867122664;19439.319623813135;19535.902320488396;19648.90175549122;20205.595888082265;18290.72563911539;18712.625747485043;18943;19155.80844191561;19450.51373715658;5176.8446946591475;5370.006548788487;5549.139883318072;5806.564507661921;5955.749292648549;5775.971120144393;5817.62185457946;5831.416858314155;5861.413858614147;5874.206982057432;5735.684537350444;6622.1722284714415;6657.766978155765;6665.900011499832;6711.161104861892;5688.516476099537;5924.763009479616;6622.834429139262;6652.800415987553;6662.300458451866;5566.777328906839;5578.832635020955;5584.6090773645865;5589.301337332833;5599.80400685974;13102.47590096395;13135.34323283832;13428.597142085753;13430.664233394145;13538.458461661521;2254.5378197469645;2291.644795056769;2304.101400453824;2377.690900182965;2624.2783234610442;9488;9848.901510984942;10311.896881031169;10323.122534584494;10692.732681682943;1886.217219853759;1928.1323404467905;1940.2917934953641;1968.3307675390292;1970.1528342812585;82386.9999999994;82744.58627706823;83840;85576.57211713902;86877;10798.460076996118;11060.391678457601;11124.944375278072;11366.715832104099;11373.601923932789;15638.139902305482;15645.217739112999;15683.215839207995;15711.450099246471;15769.44806931752;7829.569373684502;7922.128565857751;8039.7136458166415;8119.959400203079;8189.754307370788;7515.436342274242;7548.773536793905;7757.107932587712;7771.805704857424;7809.687612495437;4503.909921801545;4582.610478109332;4595.954040459619;4717.457492388351;4940.802367905244;1864.4220291709614;1880.38287073117;1978.327368694622;1987.5093679740196;2005.0977060322914;924.1036194891079;989.5101924547395;997.5211898288862;1029.330934892311;1045.4250162410797;18471.815281847008;19474.318398855972;19551.435885129154;19765;19900.203991840164;990.4404011733492;995.2684776689127;1001.6527770149138;1018.5518371916334;1024;10264.230182736324;10961.30921206848;11074.446277686084;11097.889021109848;11148.219624626197;409340;424304;446509;453460;453819;71432.64283678653;88652;88930;88990;89150;939.4363381970763;964.6430820596424;982.4203719805349;988.7231575158967;988.8615593816871;16751.91624041872;17094.57263568371;17505.474835754947;17749.556261093578;17960.461186164437;41116.1776764457;41213.381799272436;41271;41420.378694320214;42019.755653756125;52163.217551737514;52255.477445226585;52896.20655690091;60781.69609151926;61451;7981.72063977758;8008.479448835807;8060.959695201486;8217.876731849146;8421.915780842113;9086.818263634557;12039.398030098635;12761.361931903553;12800.487980480677;12906.741865162456;10674.946625266824;11454;11539.134564907834;11849.229800062969;12179.234011068169;10778.946105269424;11040.723981900517;11092.11263098934;11580;12074.154809163274;11405.600803971822;11489.712757181138;11507.194496385173;11771.941140294244;12168.330741809286;7311.926880731125;7527.623618819147;8374.330053595819;8772.956135219283;8864;10933.45332733376;11383.487743051417;11561.942190288995;11919.3444360561;11940.940295298467 23:36:22 INFO - PROCESS | 30250 | |3;mootools.html;1426.3937826423771;1462.6197188730928;1541.9229038548076;1653.371718746876;1687.4178408449088;7377.557346559211;7581.279778421048;7625.123110842254;8110.472819266751;8148.877766833502;7801.726939557117;8121.147279535652;8140.633671484783;8172.509649421039;8174.591270436469;2237.6196046672103;2294.621387471065;2297.2304278066867;2297.942551436219;2300.643400272952;2208.2933461292314;2217.556488702258;2279.886005699717;2280.692106565609;2282.1327895399727;2201.5486825200796;2226.031676220849;2226.142934970032;2238.731352237734;2248.4041728941843;2194.1662168376074;2207.9006444710026;2213.51302713402;2217.6451767717167;2219.94450138747;2206.702095217141;2212.424769559926;2212.9446763830874;2214.568159208955;2231.062953559509;8008.67965281388;8070.192980701941;8098.109207987117;8110.148434414419;8131.878021829677;4955.727434991074;5057.974710126463;5061.468545802712;5070.138076527;5082;3239;3272.839925649084;3392.5080863274934;3439.466882633196;3442.6729460701195;1146.9885301147049;1161.8257261410772;1170.373849990251;1172.8475298211263;1208.9274643521417;11147.108231341474;11166.330020198815;11329.037031852302;11354.43227838613;11362.375069371099;4287.97856010718;4325.956740432618;4457.955420445819;4554.3168524720895;4573.405457290531;9740.902590974;9750.317477776487;9781.853272200922;9791.657291994747;9812.215022798158;4950.876228094255;4991.276264941564;5002.124628190125;5006.148954677714;5036.7733451994745;4146.253674338588;4152.065785198306;4544.409226800495;4630.930536041962;4646.605038571759;3747.868824591126;3822.827972741233;3863.053551879751;3872.457855900176;3873.4383514390256;1258.9118761686777;1291.8954294078615;1297.7145028093805;1299.662087857164;1314.3493970484672;765.5253742679574;869.6347534035721;879.2218886285683;909.9308312732645;960.2318145483586;5270.183121616155;5523.143912693539;5554.08357620988;5638.548916086703;5667.036603777367;931.5714771205186;948.2982592881218;955.527014128011;962.2888158777677;975.9121679048919;3619.8009109498703;3771.0383852118084;3777.4522694209186;3813.7139714521522;3926.803659816998;9972.650957216463;10195.592176312864;10228.28402011852;10233.181345492343;10268.178545716324;10205.183585313158;10230.181585473145;10231.897681023094;10278.434686092187;10303.793924121475;7398.445116616168;7759.573223472763;7767.92232077672;7796.493227940279;7864.606769661494;5179.093658609803;5385.13837785968;5400.135978243462;5412.485813847678;5634.6337488063145;8960.462372257685;9065.138811812867;9084.137006984325;9141.725748227564;9195.218406435528;9320.673776417792;9405.81188376215;9435.669751558662;9545.713628591153;9652.517374131407;7009.824754381181;7139.178994415709;7190.352868241884;7333.193348731528;7348.081489813773;8060.435769496079;8120.390970677105;8123.8781418277595;8153.103158652425;8199.631016604148;7213.855722885618;7306.4885458017425;7335.596542190231;7346.191918889025;7446.143693475103;7186.38915692172;7217.6391180441815;7280.854382912206;7320.597367144858;7491.70033198666;6154.692265386802;6218.875622487615;6222;6233.252009758677;6316.273628532594;4594.862154135381;4624.398828152319;4665.790039448301;4691.953080469151;4722.811087556459;4743.810247590196;4840.443349014909;4840.757962101951;4873.269009648581;4968.527989840959 23:36:22 INFO - PROCESS | 30250 | |4;prototype.html;326.26264641909285;337.50892451483094;338.11919948534074;343.9759216854818;344.6915011065095;5433.782648694052;5490.533304669103;5503.284573005503;5528.336599608043;5537.667739935607;5422.105352616813;5435.402105768362;5462.371827239868;5473.698946557938;5481.972590137044;3823.9044023899346;4083.5702756859623;4177.979110104445;4182.059036716745;4185.267578173823;4209.936850947238;4225.767582782945;4235.639970602502;4239.745615263078;4275.700700950934;4230.682698797587;4244.80898359573;4252.427960513169;4270.957290427103;4276.358546218061;4000.7599544027453;4288.378185163149;4291.291936830419;4296.871093867189;4318.978405107986;3671.94492082619;3681.687056600192;3699.9445008324897;3701.3152566775234;3721.274351501458;5319.973400132974;5373.570114390839;5386.434424385461;5389.595780316492;5396.974574830809;4765.070146590636;4840.443349014873;4849.854504364875;4864.270359446076;4867.51324867514;5611.699203326616;5673.602847800656;5673.8581535461535;5680.630759000693;5686.891056244034;4033;4048.595140485928;4057.797110144481;4065.8818824823115;4072.8981775455554;5458.808941687022;5600.663960162403;5908.911366329508;5958.165856780054;5964.642121472725;4064.837406503766;4082.857100001545;4087.141700242982;4093.672506199497;4094.1167063150688;4142.606452387018;4144.191882582867;4145.79271036447;4152.43942067823;4159.334506478949;4666.929996050062;4799.424069111729;4809.9038019239415;4819.204831202883;4839.395075615548;5694.715264236772;5705.885882282331;5723.799667011718;5725.997950358671;5767.491141353525;1414.5332040426636;1438.9208093929553;1451.3759083593945;1453.0482533940285;1453.6438572549794;868.3140319147928;906.6328137104483;934.0939288889766;943.7263193673895;947.4457442396275;4698.412698412699;4711.858644240679;4745.311929770233;4780.593649539758;4806.447258565309;5057.924131138036;5067;5088.262201980692;5114.43741188469;5179.637425380187;4775.474697783241;4789.784459699322;4798.95201047992;4809.687370320918;5092.6180536459915;3063.4485792557107;3088.9536656950163;3089.165925200183;3100.4731144117472;3109.885278010974;5975.864585728697;5986.850328741816;6007.219061522062;6025.307089684655;6026.367231440723;5608.177342363748;5925.170476133345;5981.611195272293;6020.608660437058;6027.969860150759;6055.939440605625;6083.4220749029655;6114.296855861633;6115.2355955506455;6119.694015299217;5602.607817452739;5882;5893.2044174035955;5908.586398952032;5924.9703751480965;5763.423657634203;5771.942280577308;5773.393793651774;5780.479756821738;5801.3908539602735;5745.166950792028;5865.472107510344;5876.3536011039605;6013.188219590475;6044.879102418015;4112.91774164521;4150.460440142762;4177.081042170717;4193.454850869368;4205.264078786261;5923.200367950271;5954.404559544011;5964.7912323068485;5985.551083668655;5990.831787801337;5703.176927420953;5708.143778433268;5714.571407144564;5719.7426115824055;5740.68426236561;5686.71566421669;5696.259486266758;5701.429857014431;5701.771929122789;5705.058665320342;5469.562435005269;5649.604527683023;5654.660720356792;5666.801661941812;5667.696429821247;5696.0316746154085;5697.971510142423;5727.224560386294;5754.309482862083;5761.423857614205;5634.549236061187;5662.150677398423;5687.914681279702;5716.5998380113;5731.254936858182 23:36:22 INFO - PROCESS | 30250 | |5;yui.html;725.423288485654;755.0222461911827;761.1513162823453;765.9846803063937;792.255280036765;16198.919005404987;16666.000039997594;17429.82570174298;17441.476755697317;17441.7383739244;14991.850081499182;15105.62235944102;15110.244487775595;15111.168885711282;15227.629513343825;786.6695987685185;810.4003037752051;810.6190090657382;816.1838161838161;816.5304949653943;812.1594150054694;816.0696805641574;816.3999460396603;817.452306954342;820.8563501387263;861.9482831030127;867.7743786615463;867.8134201146752;870.3254977392509;870.5516658920661;852.4927668037508;856.4176360075146;856.5289090999987;860.8923884514436;864.5893200729635;628.3276893723672;630.7350912616712;634.4163369699887;634.5177664974607;634.5462993959342;12642.936785316106;12832;12870.485180592765;13101.672458188526;13143.868561314455;12323.445444955;13063.934680326538;13076.532188156929;13349.466021359134;13581.320933953262;11013.669589912315;11085.445727713663;11372.31766094037;11521.827172592419;11653;3648.799316037617;3698.223373091654;3828.157805282833;3872.9806350968347;3899.2396482685886;79305.60347198285;80291.5985420075;80511;83597.74603380893;83998.58000710019;9977.850332245021;10018.849717254247;10151.695449136538;10333.969751796805;10399.636012739518;20553.07511162001;20646.17415303401;20654.58690826175;20755.481112972295;20819.583608328052;8329.625166867385;8600.440971336842;8648.09195034525;8691.304695624334;9039.63841446348;4627.537246275346;4746.644001699887;4801.255805350176;4918.458969513351;4970.055689418999;3529.3294274087843;3634.309481198564;3659.835307411173;3670.247599242149;3675.1730860556163;608.7564974010343;617.2901163661825;633.003020243119;641.1536771461626;641.592588706175;530.603759763209;581.2298704216929;586.1969102329836;618.6737865625281;675.9387761214944;8930.553472326488;9802.509874506246;10013;10297.330673506198;10400.323978941344;705.7917914215319;708.6952610377484;718.6119495472491;723.222535774045;740.3928778401659;4508.661850361171;4759.785809638574;4790.401199850019;4802.351682522884;4847.684900481458;67991;76767.61616191884;125264;132524;133643;94359.52820235855;105865.47067264769;106058.4697076525;106725;109735;55474;92104;92763;96767;99616;8735.161072651286;9065.68270110543;9162.267018638626;9173.724788256362;9243.58403871814;43224;47557;52870.47129528655;53050.73474632602;54320.728396357765;47096;58406.70796645989;71494;74072.25927740654;79270;12108.878911211128;12168.404512930754;12220.694482638006;12265.816012759637;12696.17474864131;14203.289835507976;14360.56918292453;14540.49108281205;14735.484258050918;14761.92619036898;13376.001268149132;13468.93265533666;13517.662058448224;13774.862251377357;14262.857371426568;13142.868571314164;13470.393832277376;13654.658633534242;13899;14172.29138543048;12576.119671622899;12580.182288151607;13349.399277032362;13374.197548147142;13922.72154556883;11050.281731687415;11312;11329;11457.197996140523;11827.112966527373;11271.830922536004;11370.829437558608;11469.827952580885;11509.482073306554;11719.472623732123 23:36:22 INFO - PROCESS | 30250 | __end_tp_report 23:36:22 INFO - PROCESS | 30250 | __start_cc_report 23:36:22 INFO - PROCESS | 30250 | _x_x_mozilla_cycle_collect,315 23:36:22 INFO - PROCESS | 30250 | __end_cc_report 23:36:22 INFO - PROCESS | 30250 | __startTimestamp1475562982954__endTimestamp 23:36:22 INFO - PROCESS | 30250 | 23:36:22 INFO - PROCESS | 30250 | ------- Summary: start ------- 23:36:22 INFO - PROCESS | 30250 | Number of tests: 6 23:36:22 INFO - PROCESS | 30250 | 23:36:22 INFO - PROCESS | 30250 | [#0] dojo.html Cycles:165 Average:5268.26 Median:5430.81 stddev:581.85 (10.7%) stddev-sans-first:555.64 23:36:22 INFO - PROCESS | 30250 | Values: 2995.2 3057.7 3073.3 3074.5 3089.7 5191.7 5244.9 5310.9 5361.1 5364.5 5208.7 5208.8 5267.2 5311.6 5325.3 4734.8 4826.8 4839.8 4843.3 4867.6 4879.5 4924.5 4929.6 4955.6 4991.5 4800.7 4839.2 4848.0 4854.6 4917.4 4826.6 4833.1 4853.6 4906.9 4919.9 4777.6 4813.9 4823.5 4839.7 4882.2 5153.6 5205.1 5221.9 5261.1 5336.3 5586.8 5604.7 5643.4 5666.5 5683.5 5717.3 5758.6 5780.7 5789.2 5790.3 5227.1 5254.1 5378.9 5392.4 5393.5 5680.1 5737.1 5738.1 5740.1 5805.3 5511.9 5526.3 5526.3 5542.8 5545.0 5539.8 5566.5 5600.4 5640.0 5695.9 5673.9 5678.9 5684.0 5688.7 5700.4 5697.0 5698.1 5717.3 5718.7 5726.3 4307.6 4328.5 4357.6 4413.7 4429.8 3908.6 3931.0 3952.8 3990.8 4005.2 5378.8 5384.3 5388.6 5429.8 5430.8 5469.5 5533.3 5742.2 5743.8 5752.6 5333.8 5358.1 5366.5 5375.8 5437.0 4904.4 4940.7 4943.8 4958.1 5000.0 5679.2 5847.5 5859.5 5859.9 5872.6 5551.1 5606.9 5626.7 5653.6 5678.5 5817.1 5818.3 5823.6 5825.5 5829.6 5501.7 5536.1 5558.7 5575.6 5633.2 5705.3 5742.7 5793.2 5813.7 5818.2 5595.9 5598.2 5599.5 5601.0 5608.4 5431.6 5442.2 5526.9 5588.0 5589.6 5294.7 5390.5 5411.6 5425.8 5463.4 5493.2 5502.1 5504.8 5511.5 5519.5 5326.5 5328.4 5354.5 5377.6 5413.0 23:36:22 INFO - PROCESS | 30250 | 23:36:22 INFO - PROCESS | 30250 | [#1] ext.html Cycles:180 Average:64699.89 Median:21591.40 stddev:145714.78 (674.9%) stddev-sans-first:146043.91 23:36:22 INFO - PROCESS | 30250 | Values: 532.5 547.4 549.5 550.8 550.8 41194.6 42905.4 42973.1 46618.8 47196.0 44195.3 44836.3 44864.3 45208.8 45489.1 8882.9 8994.4 9034.8 9051.5 9072.5 8815.2 8844.4 8885.8 8894.3 8906.9 8940.6 8950.3 8973.3 8975.4 9017.4 8890.5 8933.2 8963.3 8975.4 8987.0 8844.7 8845.7 8857.5 8861.8 8898.5 41661.0 42357.4 42613.1 42672.8 42677.8 3439.6 3452.8 3585.5 3738.9 4007.6 31200.7 31209.2 31299.0 31837.4 31963.2 3825.8 3920.9 3940.0 4020.5 4353.8 346985.0 349956.0 350282.0 351277.0 352293.7 58329.7 58745.7 58842.4 58912.4 59216.7 62497.4 62702.0 63008.7 63272.4 63429.7 16101.6 16293.7 16313.9 16329.0 16340.8 12558.8 12662.9 12676.5 12699.4 12760.4 17542.7 18709.7 18837.3 18968.7 18971.4 6980.7 7191.2 7219.9 7361.7 7424.1 894.3 997.6 1028.4 1032.5 1042.4 31728.5 31928.0 31954.8 32093.0 32168.1 1046.7 1053.0 1060.8 1082.1 1133.2 15236.8 16275.6 16617.0 16717.0 16967.6 511256.0 825948.0 842053.0 842563.0 842942.0 55250.9 55542.0 55588.4 55810.4 55937.2 1316.7 1342.4 1348.2 1356.8 1361.7 29131.6 30431.7 31180.8 31181.4 31181.7 47547.5 48059.8 48079.3 48105.8 48139.0 372872.0 375921.0 376551.0 376806.0 376943.0 27622.0 27869.4 27973.3 27995.9 28136.3 43758.0 43839.6 43880.8 44099.2 45475.3 37463.8 38277.3 38374.4 38513.2 38953.2 38074.2 38201.0 38696.0 39420.8 39700.4 36569.8 36620.6 37373.4 37881.6 38179.2 32410.8 36060.5 38915.6 39242.8 40160.8 27245.0 27735.9 28020.9 28144.6 28307.6 23:36:22 INFO - PROCESS | 30250 | 23:36:22 INFO - PROCESS | 30250 | [#2] jquery.html Cycles:180 Average:27080.00 Median:204869.86 stddev:72457.58 (35.4%) stddev-sans-first:72633.14 23:36:22 INFO - PROCESS | 30250 | Values: 393.6 398.1 398.7 399.7 428.5 17806.6 19439.3 19535.9 19648.9 20205.6 18290.7 18712.6 18943.0 19155.8 19450.5 5176.8 5370.0 5549.1 5806.6 5955.7 5776.0 5817.6 5831.4 5861.4 5874.2 5735.7 6622.2 6657.8 6665.9 6711.2 5688.5 5924.8 6622.8 6652.8 6662.3 5566.8 5578.8 5584.6 5589.3 5599.8 13102.5 13135.3 13428.6 13430.7 13538.5 2254.5 2291.6 2304.1 2377.7 2624.3 9488.0 9848.9 10311.9 10323.1 10692.7 1886.2 1928.1 1940.3 1968.3 1970.2 82387.0 82744.6 83840.0 85576.6 86877.0 10798.5 11060.4 11124.9 11366.7 11373.6 15638.1 15645.2 15683.2 15711.5 15769.4 7829.6 7922.1 8039.7 8120.0 8189.8 7515.4 7548.8 7757.1 7771.8 7809.7 4503.9 4582.6 4596.0 4717.5 4940.8 1864.4 1880.4 1978.3 1987.5 2005.1 924.1 989.5 997.5 1029.3 1045.4 18471.8 19474.3 19551.4 19765.0 19900.2 990.4 995.3 1001.7 1018.6 1024.0 10264.2 10961.3 11074.4 11097.9 11148.2 409340.0 424304.0 446509.0 453460.0 453819.0 71432.6 88652.0 88930.0 88990.0 89150.0 939.4 964.6 982.4 988.7 988.9 16751.9 17094.6 17505.5 17749.6 17960.5 41116.2 41213.4 41271.0 41420.4 42019.8 52163.2 52255.5 52896.2 60781.7 61451.0 7981.7 8008.5 8061.0 8217.9 8421.9 9086.8 12039.4 12761.4 12800.5 12906.7 10674.9 11454.0 11539.1 11849.2 12179.2 10778.9 11040.7 11092.1 11580.0 12074.2 11405.6 11489.7 11507.2 11771.9 12168.3 7311.9 7527.6 8374.3 8773.0 8864.0 10933.5 11383.5 11561.9 11919.3 11940.9 23:36:22 INFO - PROCESS | 30250 | 23:36:22 INFO - PROCESS | 30250 | [#3] mootools.html Cycles:180 Average:5423.79 Median:4979.90 stddev:3020.59 (60.7%) stddev-sans-first:3014.12 23:36:22 INFO - PROCESS | 30250 | Values: 1426.4 1462.6 1541.9 1653.4 1687.4 7377.6 7581.3 7625.1 8110.5 8148.9 7801.7 8121.1 8140.6 8172.5 8174.6 2237.6 2294.6 2297.2 2297.9 2300.6 2208.3 2217.6 2279.9 2280.7 2282.1 2201.5 2226.0 2226.1 2238.7 2248.4 2194.2 2207.9 2213.5 2217.6 2219.9 2206.7 2212.4 2212.9 2214.6 2231.1 8008.7 8070.2 8098.1 8110.1 8131.9 4955.7 5058.0 5061.5 5070.1 5082.0 3239.0 3272.8 3392.5 3439.5 3442.7 1147.0 1161.8 1170.4 1172.8 1208.9 11147.1 11166.3 11329.0 11354.4 11362.4 4288.0 4326.0 4458.0 4554.3 4573.4 9740.9 9750.3 9781.9 9791.7 9812.2 4950.9 4991.3 5002.1 5006.1 5036.8 4146.3 4152.1 4544.4 4630.9 4646.6 3747.9 3822.8 3863.1 3872.5 3873.4 1258.9 1291.9 1297.7 1299.7 1314.3 765.5 869.6 879.2 909.9 960.2 5270.2 5523.1 5554.1 5638.5 5667.0 931.6 948.3 955.5 962.3 975.9 3619.8 3771.0 3777.5 3813.7 3926.8 9972.7 10195.6 10228.3 10233.2 10268.2 10205.2 10230.2 10231.9 10278.4 10303.8 7398.4 7759.6 7767.9 7796.5 7864.6 5179.1 5385.1 5400.1 5412.5 5634.6 8960.5 9065.1 9084.1 9141.7 9195.2 9320.7 9405.8 9435.7 9545.7 9652.5 7009.8 7139.2 7190.4 7333.2 7348.1 8060.4 8120.4 8123.9 8153.1 8199.6 7213.9 7306.5 7335.6 7346.2 7446.1 7186.4 7217.6 7280.9 7320.6 7491.7 6154.7 6218.9 6222.0 6233.3 6316.3 4594.9 4624.4 4665.8 4692.0 4722.8 4743.8 4840.4 4840.8 4873.3 4968.5 23:36:22 INFO - PROCESS | 30250 | 23:36:22 INFO - PROCESS | 30250 | [#4] prototype.html Cycles:180 Average:4737.39 Median:5427.94 stddev:1404.31 (25.9%) stddev-sans-first:1368.66 23:36:22 INFO - PROCESS | 30250 | Values: 326.3 337.5 338.1 344.0 344.7 5433.8 5490.5 5503.3 5528.3 5537.7 5422.1 5435.4 5462.4 5473.7 5482.0 3823.9 4083.6 4178.0 4182.1 4185.3 4209.9 4225.8 4235.6 4239.7 4275.7 4230.7 4244.8 4252.4 4271.0 4276.4 4000.8 4288.4 4291.3 4296.9 4319.0 3671.9 3681.7 3699.9 3701.3 3721.3 5320.0 5373.6 5386.4 5389.6 5397.0 4765.1 4840.4 4849.9 4864.3 4867.5 5611.7 5673.6 5673.9 5680.6 5686.9 4033.0 4048.6 4057.8 4065.9 4072.9 5458.8 5600.7 5908.9 5958.2 5964.6 4064.8 4082.9 4087.1 4093.7 4094.1 4142.6 4144.2 4145.8 4152.4 4159.3 4666.9 4799.4 4809.9 4819.2 4839.4 5694.7 5705.9 5723.8 5726.0 5767.5 1414.5 1438.9 1451.4 1453.0 1453.6 868.3 906.6 934.1 943.7 947.4 4698.4 4711.9 4745.3 4780.6 4806.4 5057.9 5067.0 5088.3 5114.4 5179.6 4775.5 4789.8 4799.0 4809.7 5092.6 3063.4 3089.0 3089.2 3100.5 3109.9 5975.9 5986.9 6007.2 6025.3 6026.4 5608.2 5925.2 5981.6 6020.6 6028.0 6055.9 6083.4 6114.3 6115.2 6119.7 5602.6 5882.0 5893.2 5908.6 5925.0 5763.4 5771.9 5773.4 5780.5 5801.4 5745.2 5865.5 5876.4 6013.2 6044.9 4112.9 4150.5 4177.1 4193.5 4205.3 5923.2 5954.4 5964.8 5985.6 5990.8 5703.2 5708.1 5714.6 5719.7 5740.7 5686.7 5696.3 5701.4 5701.8 5705.1 5469.6 5649.6 5654.7 5666.8 5667.7 5696.0 5698.0 5727.2 5754.3 5761.4 5634.5 5662.2 5687.9 5716.6 5731.3 23:36:22 INFO - PROCESS | 30250 | 23:36:22 INFO - PROCESS | 30250 | [#5] yui.html Cycles:180 Average:20521.00 Median:4568.10 stddev:30236.28 (661.9%) stddev-sans-first:30284.56 23:36:22 INFO - PROCESS | 30250 | Values: 725.4 755.0 761.2 766.0 792.3 16198.9 16666.0 17429.8 17441.5 17441.7 14991.9 15105.6 15110.2 15111.2 15227.6 786.7 810.4 810.6 816.2 816.5 812.2 816.1 816.4 817.5 820.9 861.9 867.8 867.8 870.3 870.6 852.5 856.4 856.5 860.9 864.6 628.3 630.7 634.4 634.5 634.5 12642.9 12832.0 12870.5 13101.7 13143.9 12323.4 13063.9 13076.5 13349.5 13581.3 11013.7 11085.4 11372.3 11521.8 11653.0 3648.8 3698.2 3828.2 3873.0 3899.2 79305.6 80291.6 80511.0 83597.7 83998.6 9977.9 10018.8 10151.7 10334.0 10399.6 20553.1 20646.2 20654.6 20755.5 20819.6 8329.6 8600.4 8648.1 8691.3 9039.6 4627.5 4746.6 4801.3 4918.5 4970.1 3529.3 3634.3 3659.8 3670.2 3675.2 608.8 617.3 633.0 641.2 641.6 530.6 581.2 586.2 618.7 675.9 8930.6 9802.5 10013.0 10297.3 10400.3 705.8 708.7 718.6 723.2 740.4 4508.7 4759.8 4790.4 4802.4 4847.7 67991.0 76767.6 125264.0 132524.0 133643.0 94359.5 105865.5 106058.5 106725.0 109735.0 55474.0 92104.0 92763.0 96767.0 99616.0 8735.2 9065.7 9162.3 9173.7 9243.6 43224.0 47557.0 52870.5 53050.7 54320.7 47096.0 58406.7 71494.0 74072.3 79270.0 12108.9 12168.4 12220.7 12265.8 12696.2 14203.3 14360.6 14540.5 14735.5 14761.9 13376.0 13468.9 13517.7 13774.9 14262.9 13142.9 13470.4 13654.7 13899.0 14172.3 12576.1 12580.2 13349.4 13374.2 13922.7 11050.3 11312.0 11329.0 11457.2 11827.1 11271.8 11370.8 11469.8 11509.5 11719.5 23:36:22 INFO - PROCESS | 30250 | -------- Summary: end -------- 23:36:22 INFO - PROCESS | 30250 | 23:36:23 INFO - TEST-INFO | 30250: exit 0 23:36:23 INFO - TEST-OK | dromaeo_css | took 1115332ms 23:36:23 INFO - TEST-START | kraken 23:36:23 INFO - operating with platform_type : linux_ 23:36:23 INFO - Initialising browser for kraken test... 23:36:24 INFO - TEST-INFO | started process 30603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM3Xp1J/profile http://localhost:43923/getInfo.html) 23:36:28 INFO - PROCESS | 30603 | __metrics Screen width/height:1600/1200 23:36:28 INFO - PROCESS | 30603 | colorDepth:24 23:36:28 INFO - PROCESS | 30603 | Browser inner width/height: 1024/697 23:36:28 INFO - PROCESS | 30603 | __metrics 23:36:29 ERROR - PROCESS | 30603 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 23:36:30 INFO - TEST-INFO | 30603: exit 0 23:36:30 INFO - Browser initialized. 23:36:30 INFO - Running cycle 1/1 for kraken test... 23:36:30 INFO - TEST-INFO | started process 30724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM3Xp1J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:42 INFO - PROCESS | 30724 | RSS: Main: 185405440 23:36:42 INFO - PROCESS | 30724 | 23:36:45 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43923/tests/kraken/driver.html?testName=audio-beat-detection) 23:36:46 INFO - PROCESS | 30724 | RSS: Main: 199577600 23:36:46 INFO - PROCESS | 30724 | 23:36:48 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43923/tests/kraken/driver.html?testName=audio-dft) 23:36:49 INFO - PROCESS | 30724 | RSS: Main: 197734400 23:36:49 INFO - PROCESS | 30724 | 23:36:52 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43923/tests/kraken/driver.html?testName=audio-fft) 23:36:53 INFO - PROCESS | 30724 | RSS: Main: 192880640 23:36:53 INFO - PROCESS | 30724 | 23:36:55 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43923/tests/kraken/driver.html?testName=audio-oscillator) 23:36:55 INFO - PROCESS | 30724 | RSS: Main: 193802240 23:36:55 INFO - PROCESS | 30724 | 23:36:57 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43923/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:36:58 INFO - PROCESS | 30724 | RSS: Main: 194273280 23:36:58 INFO - PROCESS | 30724 | 23:37:01 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43923/tests/kraken/driver.html?testName=imaging-darkroom) 23:37:02 INFO - PROCESS | 30724 | RSS: Main: 194768896 23:37:02 INFO - PROCESS | 30724 | 23:37:05 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43923/tests/kraken/driver.html?testName=imaging-desaturate) 23:37:06 INFO - PROCESS | 30724 | RSS: Main: 192434176 23:37:06 INFO - PROCESS | 30724 | 23:37:09 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43923/tests/kraken/driver.html?testName=json-parse-financial) 23:37:09 INFO - PROCESS | 30724 | RSS: Main: 193581056 23:37:09 INFO - PROCESS | 30724 | 23:37:11 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43923/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:37:11 INFO - PROCESS | 30724 | RSS: Main: 193679360 23:37:11 INFO - PROCESS | 30724 | 23:37:13 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:37:14 INFO - PROCESS | 30724 | RSS: Main: 193925120 23:37:14 INFO - PROCESS | 30724 | 23:37:16 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:37:17 INFO - PROCESS | 30724 | RSS: Main: 194904064 23:37:17 INFO - PROCESS | 30724 | 23:37:19 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:37:20 INFO - PROCESS | 30724 | RSS: Main: 194113536 23:37:20 INFO - PROCESS | 30724 | 23:37:23 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:37:24 INFO - PROCESS | 30724 | RSS: Main: 194633728 23:37:24 INFO - PROCESS | 30724 | 23:37:25 INFO - PROCESS | 30724 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43923/tests/kraken/driver.html?testName=ai-astar) 23:37:26 INFO - PROCESS | 30724 | RSS: Main: 195981312 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | __start_tp_report 23:37:26 INFO - PROCESS | 30724 | _x_x_mozilla_page_load 23:37:26 INFO - PROCESS | 30724 | _x_x_mozilla_page_load_details 23:37:26 INFO - PROCESS | 30724 | |i|pagename|runs| 23:37:26 INFO - PROCESS | 30724 | |0;ai-astar;107;114;114;113;113;114;114;113;113;114 23:37:26 INFO - PROCESS | 30724 | |1;audio-beat-detection;155;127;127;176;128;132;133;127;154;129 23:37:26 INFO - PROCESS | 30724 | |2;audio-dft;165;165;166;171;163;166;164;164;165;163 23:37:26 INFO - PROCESS | 30724 | |3;audio-fft;77;77;78;112;77;77;79;78;101;78 23:37:26 INFO - PROCESS | 30724 | |4;audio-oscillator;83;83;124;82;84;82;103;83;82;105 23:37:26 INFO - PROCESS | 30724 | |5;imaging-gaussian-blur;117;119;117;119;118;118;117;119;119;118 23:37:26 INFO - PROCESS | 30724 | |6;imaging-darkroom;147;149;147;149;148;148;147;149;149;149 23:37:26 INFO - PROCESS | 30724 | |7;imaging-desaturate;98;98;98;96;98;96;96;96;96;97 23:37:26 INFO - PROCESS | 30724 | |8;json-parse-financial;55;53;53;53;56;55;53;56;55;53 23:37:26 INFO - PROCESS | 30724 | |9;json-stringify-tinderbox;61;63;62;63;63;61;62;63;64;63 23:37:26 INFO - PROCESS | 30724 | |10;stanford-crypto-aes;82;81;86;80;82;80;80;81;82;80 23:37:26 INFO - PROCESS | 30724 | |11;stanford-crypto-ccm;133;148;135;135;142;140;144;141;178;141 23:37:26 INFO - PROCESS | 30724 | |12;stanford-crypto-pbkdf2;177;167;167;173;170;175;172;171;171;172 23:37:26 INFO - PROCESS | 30724 | |13;stanford-crypto-sha256-iterative;70;67;69;68;66;68;67;66;66;66 23:37:26 INFO - PROCESS | 30724 | __end_tp_report 23:37:26 INFO - PROCESS | 30724 | __start_cc_report 23:37:26 INFO - PROCESS | 30724 | _x_x_mozilla_cycle_collect,766 23:37:26 INFO - PROCESS | 30724 | __end_cc_report 23:37:26 INFO - PROCESS | 30724 | __startTimestamp1475563046061__endTimestamp 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | ------- Summary: start ------- 23:37:26 INFO - PROCESS | 30724 | Number of tests: 14 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.13 (1.9%) stddev-sans-first:0.53 23:37:26 INFO - PROCESS | 30724 | Values: 107.0 114.0 114.0 113.0 113.0 114.0 114.0 113.0 113.0 114.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:132.50 stddev:16.96 (12.8%) stddev-sans-first:16.94 23:37:26 INFO - PROCESS | 30724 | Values: 155.0 127.0 127.0 176.0 128.0 132.0 133.0 127.0 154.0 129.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:2.30 (1.4%) stddev-sans-first:2.44 23:37:26 INFO - PROCESS | 30724 | Values: 165.0 165.0 166.0 171.0 163.0 166.0 164.0 164.0 165.0 163.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#3] audio-fft Cycles:10 Average:83.40 Median:77.50 stddev:12.47 (16.1%) stddev-sans-first:13.00 23:37:26 INFO - PROCESS | 30724 | Values: 77.0 77.0 78.0 112.0 77.0 77.0 79.0 78.0 101.0 78.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.50 stddev:14.58 (17.7%) stddev-sans-first:15.17 23:37:26 INFO - PROCESS | 30724 | Values: 83.0 83.0 124.0 82.0 84.0 82.0 103.0 83.0 82.0 105.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.50 stddev:0.88 (0.7%) stddev-sans-first:0.83 23:37:26 INFO - PROCESS | 30724 | Values: 117.0 119.0 117.0 119.0 118.0 118.0 117.0 119.0 119.0 118.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:149.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 23:37:26 INFO - PROCESS | 30724 | Values: 147.0 149.0 147.0 149.0 148.0 148.0 147.0 149.0 149.0 149.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.50 stddev:0.99 (1.0%) stddev-sans-first:0.97 23:37:26 INFO - PROCESS | 30724 | Values: 98.0 98.0 98.0 96.0 98.0 96.0 96.0 96.0 96.0 97.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.32 (2.4%) stddev-sans-first:1.36 23:37:26 INFO - PROCESS | 30724 | Values: 55.0 53.0 53.0 53.0 56.0 55.0 53.0 56.0 55.0 53.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:0.87 23:37:26 INFO - PROCESS | 30724 | Values: 61.0 63.0 62.0 63.0 63.0 61.0 62.0 63.0 64.0 63.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:1.84 (2.3%) stddev-sans-first:1.94 23:37:26 INFO - PROCESS | 30724 | Values: 82.0 81.0 86.0 80.0 82.0 80.0 80.0 81.0 82.0 80.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:141.50 stddev:12.88 (9.1%) stddev-sans-first:13.06 23:37:26 INFO - PROCESS | 30724 | Values: 133.0 148.0 135.0 135.0 142.0 140.0 144.0 141.0 178.0 141.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.00 stddev:3.14 (1.8%) stddev-sans-first:2.62 23:37:26 INFO - PROCESS | 30724 | Values: 177.0 167.0 167.0 173.0 170.0 175.0 172.0 171.0 171.0 172.0 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.42 (2.1%) stddev-sans-first:1.12 23:37:26 INFO - PROCESS | 30724 | Values: 70.0 67.0 69.0 68.0 66.0 68.0 67.0 66.0 66.0 66.0 23:37:26 INFO - PROCESS | 30724 | -------- Summary: end -------- 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | 23:37:26 INFO - PROCESS | 30724 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:37:26 INFO - PROCESS | 30724 | 23:37:27 INFO - TEST-INFO | 30724: exit 0 23:37:27 INFO - TEST-OK | kraken | took 63258ms 23:37:27 INFO - SUITE-END | took 1178s 23:37:27 INFO - Completed test suite (00:19:39) 23:37:27 INFO - javascript benchmark 23:37:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7132.388329967946, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2995.16135482065, 3057.740092092172, 3073.277779721765, 3074.477338852394, 3089.6755840636733, 5191.688498690081, 5244.947550524494, 5310.893782124355, 5361.088614935461, 5364.490373414525, 5208.713520756357, 5208.791648334071, 5267.209918512225, 5311.57507399408, 5325.254464374981, 4734.763261836912, 4826.806927722887, 4839.814245509855, 4843.297721830332, 4867.610591152717, 4879.463259041502, 4924.532169443897, 4929.580985616209, 4955.578775804061, 4991.500849915015, 4800.735959522225, 4839.153148199051, 4847.975760121194, 4854.587360074398, 4917.434495033063, 4826.638002149853, 4833.130036593412, 4853.611711063107, 4906.852794416173, 4919.877003074916, 4777.617790576745, 4813.927791083137, 4823.5176482351835, 4839.685420447695, 4882.2432522959, 5153.587712982952, 5205.063088644042, 5221.895562088775, 5261.1319132343115, 5336.30628018359, 5586.776528938837, 5604.747786349624, 5643.351014633328, 5666.490015898589, 5683.5169010634145, 5717.313922329347, 5758.596898217126, 5780.653160810365, 5789.16057171712, 5790.276215473066, 5227.137522308776, 5254.133068043807, 5378.919316210221, 5392.352917649907, 5393.460653934575, 5680.062789639664, 5737.08206686928, 5738.081906894877, 5740.0815869460685, 5805.303363596396, 5511.862203444946, 5526.253955715927, 5526.336839579196, 5542.8337149885565, 5544.972275138679, 5539.750711218005, 5566.4990150886615, 5600.4399560044485, 5640.012997725382, 5695.943040569624, 5673.886522269531, 5678.886422271614, 5684.033714268584, 5688.687122208235, 5700.4299570043495, 5696.971515142398, 5698.116791897262, 5717.342505611825, 5718.714064296852, 5726.341470730919, 4307.612314891612, 4328.458942632171, 4357.629601483846, 4413.668974826836, 4429.7785110744335, 3908.6091390861257, 3931.0368959604507, 3952.782596957195, 3990.780507072139, 4005.178938317638, 5378.838634840961, 5384.326959130109, 5388.568914486832, 5429.809956651498, 5430.8099216527235, 5469.507744302952, 5533.3083364579425, 5742.196092547047, 5743.798967036134, 5752.626079304831, 5333.759980800874, 5358.142697168512, 5366.543843773245, 5375.784968601212, 5436.972815135978, 4904.435989861212, 4940.740111271674, 4943.777530011158, 4958.057968985881, 4999.950000499948, 5679.204911312502, 5847.473727364558, 5859.5019423349495, 5859.853503662443, 5872.618279811884, 5551.139573366135, 5606.887862242814, 5626.718664066862, 5653.604247702786, 5678.488935995781, 5817.127430885401, 5818.33089194748, 5823.621464604787, 5825.475707186204, 5829.562782791223, 5501.669899806025, 5536.0865457200725, 5558.72206389687, 5575.553955683455, 5633.183188437735, 5705.34388545306, 5742.684152371659, 5793.159991801081, 5813.651180929158, 5818.214541036906, 5595.944040559705, 5598.188262701967, 5599.496045355938, 5600.971995139998, 5608.4111168326735, 5431.646942948696, 5442.238086667949, 5526.889462210653, 5588.0, 5589.580781441489, 5294.655847369909, 5390.541803946551, 5411.594130440154, 5425.810096646598, 5463.426340234377, 5493.176023596492, 5502.0921547945745, 5504.7522861470525, 5511.53151982086, 5519.530839878656, 5326.547243484192, 5328.360596728262, 5354.464553544614, 5377.623566350318, 5412.972935135299], "value": 5229.807165742544, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.4675324675325, 547.4197350808143, 549.4560385218633, 550.7796881247504, 550.8347495751271, 41194.58805411945, 42905.35641965369, 42973.14053718924, 46618.76690616542, 47196.0, 44195.33706994398, 44836.3274550882, 44864.327035094415, 45208.77395613026, 45489.0902181957, 8882.866756998634, 8994.415363001384, 9034.774130646754, 9051.456912585267, 9072.455652660861, 8815.206631403173, 8844.38089333747, 8885.822283554326, 8894.288456923463, 8906.910930890705, 8940.64237430502, 8950.283977281835, 8973.327000474957, 8975.416597921147, 9017.36878418511, 8890.51102189376, 8933.240674542672, 8963.282937365027, 8975.371723979324, 8986.955065224698, 8844.690435834715, 8845.734627961172, 8857.468551886843, 8861.822763544693, 8898.4660920345, 41661.0, 42357.36463953043, 42613.147737045394, 42672.78663606662, 42677.78661106706, 3439.5872495300473, 3452.7755695879937, 3585.515955346021, 3738.8504459821575, 4007.6192761687594, 31200.687993120006, 31209.21976950572, 31299.04184571818, 31837.363252734816, 31963.200919976953, 3825.7513261637905, 3920.882373528799, 3940.0, 4020.537638171589, 4353.760543170124, 346985.0, 349956.0, 350282.0, 351277.0, 352293.6697215585, 58329.70835145882, 58745.70627146922, 58842.41157588369, 58912.410875891546, 59216.70391648014, 62497.37502625006, 62702.0, 63008.68495657584, 63272.36727632757, 63429.68285158544, 16101.597460063593, 16293.67412651764, 16313.918430407772, 16329.0, 16340.75488867668, 12558.81161782574, 12662.873371266354, 12676.492940282285, 12699.365031748375, 12760.425780839885, 17542.733327983347, 18709.719354209425, 18837.340693075676, 18968.715469267972, 18971.43085707431, 6980.743466176137, 7191.208967013625, 7219.880918457648, 7361.705531778669, 7424.146223184295, 894.3069121430943, 997.5760301871676, 1028.4292217819182, 1032.4528000159928, 1042.3797840285017, 31728.524072138935, 31928.0, 31954.84022579872, 32093.0, 32168.06991580513, 1046.6859942017363, 1052.9789404212027, 1060.7666313411037, 1082.1288862465633, 1133.1614605192099, 15236.771448428282, 16275.59311017234, 16617.0, 16717.0, 16967.575810604834, 511256.0, 825948.0, 842053.0, 842563.0, 842942.0, 55250.85618578542, 55542.0, 55588.444115559134, 55810.44189558134, 55937.16094258589, 1316.7432350691522, 1342.4026308292716, 1348.1506650810122, 1356.8439629442544, 1361.700425906299, 29131.563026554195, 30431.695683042886, 31180.844095779375, 31181.376372472878, 31181.688183118786, 47547.524524754306, 48059.75970120127, 48079.278810817166, 48105.75947120242, 48139.0, 372872.0, 375921.0, 376551.0, 376806.0, 376943.0, 27622.0, 27869.442611148068, 27973.300667483476, 27995.940588614943, 28136.327048930318, 43758.0, 43839.56160438355, 43880.78059609682, 44099.236030558415, 45475.31787023131, 37463.81268093751, 38277.277522510994, 38374.424383634825, 38513.229735405694, 38953.220935581696, 38074.23851523009, 38201.0, 38696.0, 39420.80289598534, 39700.404493933194, 36569.817150915136, 36620.63379366172, 37373.4393984085, 37881.62118378781, 38179.23641527209, 32410.83794581012, 36060.4590931131, 38915.6108438912, 39242.80378598089, 40160.799196003834, 27245.003049664916, 27735.861320693268, 28020.859895700392, 28144.577831332135, 28307.575386368808], "value": 19884.508202674864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.5788706084489, 398.1042654028432, 398.7439565369087, 399.71021009767924, 428.5243379848368, 17806.643867122664, 19439.319623813135, 19535.902320488396, 19648.90175549122, 20205.595888082265, 18290.72563911539, 18712.625747485043, 18943.0, 19155.80844191561, 19450.51373715658, 5176.8446946591475, 5370.006548788487, 5549.139883318072, 5806.564507661921, 5955.749292648549, 5775.971120144393, 5817.62185457946, 5831.416858314155, 5861.413858614147, 5874.206982057432, 5735.684537350444, 6622.1722284714415, 6657.766978155765, 6665.900011499832, 6711.161104861892, 5688.516476099537, 5924.763009479616, 6622.834429139262, 6652.800415987553, 6662.300458451866, 5566.777328906839, 5578.832635020955, 5584.6090773645865, 5589.301337332833, 5599.80400685974, 13102.47590096395, 13135.34323283832, 13428.597142085753, 13430.664233394145, 13538.458461661521, 2254.5378197469645, 2291.644795056769, 2304.101400453824, 2377.690900182965, 2624.2783234610442, 9488.0, 9848.901510984942, 10311.896881031169, 10323.122534584494, 10692.732681682943, 1886.217219853759, 1928.1323404467905, 1940.2917934953641, 1968.3307675390292, 1970.1528342812585, 82386.9999999994, 82744.58627706823, 83840.0, 85576.57211713902, 86877.0, 10798.460076996118, 11060.391678457601, 11124.944375278072, 11366.715832104099, 11373.601923932789, 15638.139902305482, 15645.217739112999, 15683.215839207995, 15711.450099246471, 15769.44806931752, 7829.569373684502, 7922.128565857751, 8039.7136458166415, 8119.959400203079, 8189.754307370788, 7515.436342274242, 7548.773536793905, 7757.107932587712, 7771.805704857424, 7809.687612495437, 4503.909921801545, 4582.610478109332, 4595.954040459619, 4717.457492388351, 4940.802367905244, 1864.4220291709614, 1880.38287073117, 1978.327368694622, 1987.5093679740196, 2005.0977060322914, 924.1036194891079, 989.5101924547395, 997.5211898288862, 1029.330934892311, 1045.4250162410797, 18471.815281847008, 19474.318398855972, 19551.435885129154, 19765.0, 19900.203991840164, 990.4404011733492, 995.2684776689127, 1001.6527770149138, 1018.5518371916334, 1024.0, 10264.230182736324, 10961.30921206848, 11074.446277686084, 11097.889021109848, 11148.219624626197, 409340.0, 424304.0, 446509.0, 453460.0, 453819.0, 71432.64283678653, 88652.0, 88930.0, 88990.0, 89150.0, 939.4363381970763, 964.6430820596424, 982.4203719805349, 988.7231575158967, 988.8615593816871, 16751.91624041872, 17094.57263568371, 17505.474835754947, 17749.556261093578, 17960.461186164437, 41116.1776764457, 41213.381799272436, 41271.0, 41420.378694320214, 42019.755653756125, 52163.217551737514, 52255.477445226585, 52896.20655690091, 60781.69609151926, 61451.0, 7981.72063977758, 8008.479448835807, 8060.959695201486, 8217.876731849146, 8421.915780842113, 9086.818263634557, 12039.398030098635, 12761.361931903553, 12800.487980480677, 12906.741865162456, 10674.946625266824, 11454.0, 11539.134564907834, 11849.229800062969, 12179.234011068169, 10778.946105269424, 11040.723981900517, 11092.11263098934, 11580.0, 12074.154809163274, 11405.600803971822, 11489.712757181138, 11507.194496385173, 11771.941140294244, 12168.330741809286, 7311.926880731125, 7527.623618819147, 8374.330053595819, 8772.956135219283, 8864.0, 10933.45332733376, 11383.487743051417, 11561.942190288995, 11919.3444360561, 11940.940295298467], "value": 9020.415391721084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.3937826423771, 1462.6197188730928, 1541.9229038548076, 1653.371718746876, 1687.4178408449088, 7377.557346559211, 7581.279778421048, 7625.123110842254, 8110.472819266751, 8148.877766833502, 7801.726939557117, 8121.147279535652, 8140.633671484783, 8172.509649421039, 8174.591270436469, 2237.6196046672103, 2294.621387471065, 2297.2304278066867, 2297.942551436219, 2300.643400272952, 2208.2933461292314, 2217.556488702258, 2279.886005699717, 2280.692106565609, 2282.1327895399727, 2201.5486825200796, 2226.031676220849, 2226.142934970032, 2238.731352237734, 2248.4041728941843, 2194.1662168376074, 2207.9006444710026, 2213.51302713402, 2217.6451767717167, 2219.94450138747, 2206.702095217141, 2212.424769559926, 2212.9446763830874, 2214.568159208955, 2231.062953559509, 8008.67965281388, 8070.192980701941, 8098.109207987117, 8110.148434414419, 8131.878021829677, 4955.727434991074, 5057.974710126463, 5061.468545802712, 5070.138076527, 5082.0, 3239.0, 3272.839925649084, 3392.5080863274934, 3439.466882633196, 3442.6729460701195, 1146.9885301147049, 1161.8257261410772, 1170.373849990251, 1172.8475298211263, 1208.9274643521417, 11147.108231341474, 11166.330020198815, 11329.037031852302, 11354.43227838613, 11362.375069371099, 4287.97856010718, 4325.956740432618, 4457.955420445819, 4554.3168524720895, 4573.405457290531, 9740.902590974, 9750.317477776487, 9781.853272200922, 9791.657291994747, 9812.215022798158, 4950.876228094255, 4991.276264941564, 5002.124628190125, 5006.148954677714, 5036.7733451994745, 4146.253674338588, 4152.065785198306, 4544.409226800495, 4630.930536041962, 4646.605038571759, 3747.868824591126, 3822.827972741233, 3863.053551879751, 3872.457855900176, 3873.4383514390256, 1258.9118761686777, 1291.8954294078615, 1297.7145028093805, 1299.662087857164, 1314.3493970484672, 765.5253742679574, 869.6347534035721, 879.2218886285683, 909.9308312732645, 960.2318145483586, 5270.183121616155, 5523.143912693539, 5554.08357620988, 5638.548916086703, 5667.036603777367, 931.5714771205186, 948.2982592881218, 955.527014128011, 962.2888158777677, 975.9121679048919, 3619.8009109498703, 3771.0383852118084, 3777.4522694209186, 3813.7139714521522, 3926.803659816998, 9972.650957216463, 10195.592176312864, 10228.28402011852, 10233.181345492343, 10268.178545716324, 10205.183585313158, 10230.181585473145, 10231.897681023094, 10278.434686092187, 10303.793924121475, 7398.445116616168, 7759.573223472763, 7767.92232077672, 7796.493227940279, 7864.606769661494, 5179.093658609803, 5385.13837785968, 5400.135978243462, 5412.485813847678, 5634.6337488063145, 8960.462372257685, 9065.138811812867, 9084.137006984325, 9141.725748227564, 9195.218406435528, 9320.673776417792, 9405.81188376215, 9435.669751558662, 9545.713628591153, 9652.517374131407, 7009.824754381181, 7139.178994415709, 7190.352868241884, 7333.193348731528, 7348.081489813773, 8060.435769496079, 8120.390970677105, 8123.8781418277595, 8153.103158652425, 8199.631016604148, 7213.855722885618, 7306.4885458017425, 7335.596542190231, 7346.191918889025, 7446.143693475103, 7186.38915692172, 7217.6391180441815, 7280.854382912206, 7320.597367144858, 7491.70033198666, 6154.692265386802, 6218.875622487615, 6222.0, 6233.252009758677, 6316.273628532594, 4594.862154135381, 4624.398828152319, 4665.790039448301, 4691.953080469151, 4722.811087556459, 4743.810247590196, 4840.443349014909, 4840.757962101951, 4873.269009648581, 4968.527989840959], "value": 4392.348985463175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.26264641909285, 337.50892451483094, 338.11919948534074, 343.9759216854818, 344.6915011065095, 5433.782648694052, 5490.533304669103, 5503.284573005503, 5528.336599608043, 5537.667739935607, 5422.105352616813, 5435.402105768362, 5462.371827239868, 5473.698946557938, 5481.972590137044, 3823.9044023899346, 4083.5702756859623, 4177.979110104445, 4182.059036716745, 4185.267578173823, 4209.936850947238, 4225.767582782945, 4235.639970602502, 4239.745615263078, 4275.700700950934, 4230.682698797587, 4244.80898359573, 4252.427960513169, 4270.957290427103, 4276.358546218061, 4000.7599544027453, 4288.378185163149, 4291.291936830419, 4296.871093867189, 4318.978405107986, 3671.94492082619, 3681.687056600192, 3699.9445008324897, 3701.3152566775234, 3721.274351501458, 5319.973400132974, 5373.570114390839, 5386.434424385461, 5389.595780316492, 5396.974574830809, 4765.070146590636, 4840.443349014873, 4849.854504364875, 4864.270359446076, 4867.51324867514, 5611.699203326616, 5673.602847800656, 5673.8581535461535, 5680.630759000693, 5686.891056244034, 4033.0, 4048.595140485928, 4057.797110144481, 4065.8818824823115, 4072.8981775455554, 5458.808941687022, 5600.663960162403, 5908.911366329508, 5958.165856780054, 5964.642121472725, 4064.837406503766, 4082.857100001545, 4087.141700242982, 4093.672506199497, 4094.1167063150688, 4142.606452387018, 4144.191882582867, 4145.79271036447, 4152.43942067823, 4159.334506478949, 4666.929996050062, 4799.424069111729, 4809.9038019239415, 4819.204831202883, 4839.395075615548, 5694.715264236772, 5705.885882282331, 5723.799667011718, 5725.997950358671, 5767.491141353525, 1414.5332040426636, 1438.9208093929553, 1451.3759083593945, 1453.0482533940285, 1453.6438572549794, 868.3140319147928, 906.6328137104483, 934.0939288889766, 943.7263193673895, 947.4457442396275, 4698.412698412699, 4711.858644240679, 4745.311929770233, 4780.593649539758, 4806.447258565309, 5057.924131138036, 5067.0, 5088.262201980692, 5114.43741188469, 5179.637425380187, 4775.474697783241, 4789.784459699322, 4798.95201047992, 4809.687370320918, 5092.6180536459915, 3063.4485792557107, 3088.9536656950163, 3089.165925200183, 3100.4731144117472, 3109.885278010974, 5975.864585728697, 5986.850328741816, 6007.219061522062, 6025.307089684655, 6026.367231440723, 5608.177342363748, 5925.170476133345, 5981.611195272293, 6020.608660437058, 6027.969860150759, 6055.939440605625, 6083.4220749029655, 6114.296855861633, 6115.2355955506455, 6119.694015299217, 5602.607817452739, 5882.0, 5893.2044174035955, 5908.586398952032, 5924.9703751480965, 5763.423657634203, 5771.942280577308, 5773.393793651774, 5780.479756821738, 5801.3908539602735, 5745.166950792028, 5865.472107510344, 5876.3536011039605, 6013.188219590475, 6044.879102418015, 4112.91774164521, 4150.460440142762, 4177.081042170717, 4193.454850869368, 4205.264078786261, 5923.200367950271, 5954.404559544011, 5964.7912323068485, 5985.551083668655, 5990.831787801337, 5703.176927420953, 5708.143778433268, 5714.571407144564, 5719.7426115824055, 5740.68426236561, 5686.71566421669, 5696.259486266758, 5701.429857014431, 5701.771929122789, 5705.058665320342, 5469.562435005269, 5649.604527683023, 5654.660720356792, 5666.801661941812, 5667.696429821247, 5696.0316746154085, 5697.971510142423, 5727.224560386294, 5754.309482862083, 5761.423857614205, 5634.549236061187, 5662.150677398423, 5687.914681279702, 5716.5998380113, 5731.254936858182], "value": 4288.880630012286, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.423288485654, 755.0222461911827, 761.1513162823453, 765.9846803063937, 792.255280036765, 16198.919005404987, 16666.000039997594, 17429.82570174298, 17441.476755697317, 17441.7383739244, 14991.850081499182, 15105.62235944102, 15110.244487775595, 15111.168885711282, 15227.629513343825, 786.6695987685185, 810.4003037752051, 810.6190090657382, 816.1838161838161, 816.5304949653943, 812.1594150054694, 816.0696805641574, 816.3999460396603, 817.452306954342, 820.8563501387263, 861.9482831030127, 867.7743786615463, 867.8134201146752, 870.3254977392509, 870.5516658920661, 852.4927668037508, 856.4176360075146, 856.5289090999987, 860.8923884514436, 864.5893200729635, 628.3276893723672, 630.7350912616712, 634.4163369699887, 634.5177664974607, 634.5462993959342, 12642.936785316106, 12832.0, 12870.485180592765, 13101.672458188526, 13143.868561314455, 12323.445444955, 13063.934680326538, 13076.532188156929, 13349.466021359134, 13581.320933953262, 11013.669589912315, 11085.445727713663, 11372.31766094037, 11521.827172592419, 11653.0, 3648.799316037617, 3698.223373091654, 3828.157805282833, 3872.9806350968347, 3899.2396482685886, 79305.60347198285, 80291.5985420075, 80511.0, 83597.74603380893, 83998.58000710019, 9977.850332245021, 10018.849717254247, 10151.695449136538, 10333.969751796805, 10399.636012739518, 20553.07511162001, 20646.17415303401, 20654.58690826175, 20755.481112972295, 20819.583608328052, 8329.625166867385, 8600.440971336842, 8648.09195034525, 8691.304695624334, 9039.63841446348, 4627.537246275346, 4746.644001699887, 4801.255805350176, 4918.458969513351, 4970.055689418999, 3529.3294274087843, 3634.309481198564, 3659.835307411173, 3670.247599242149, 3675.1730860556163, 608.7564974010343, 617.2901163661825, 633.003020243119, 641.1536771461626, 641.592588706175, 530.603759763209, 581.2298704216929, 586.1969102329836, 618.6737865625281, 675.9387761214944, 8930.553472326488, 9802.509874506246, 10013.0, 10297.330673506198, 10400.323978941344, 705.7917914215319, 708.6952610377484, 718.6119495472491, 723.222535774045, 740.3928778401659, 4508.661850361171, 4759.785809638574, 4790.401199850019, 4802.351682522884, 4847.684900481458, 67991.0, 76767.61616191884, 125264.0, 132524.0, 133643.0, 94359.52820235855, 105865.47067264769, 106058.4697076525, 106725.0, 109735.0, 55474.0, 92104.0, 92763.0, 96767.0, 99616.0, 8735.161072651286, 9065.68270110543, 9162.267018638626, 9173.724788256362, 9243.58403871814, 43224.0, 47557.0, 52870.47129528655, 53050.73474632602, 54320.728396357765, 47096.0, 58406.70796645989, 71494.0, 74072.25927740654, 79270.0, 12108.878911211128, 12168.404512930754, 12220.694482638006, 12265.816012759637, 12696.17474864131, 14203.289835507976, 14360.56918292453, 14540.49108281205, 14735.484258050918, 14761.92619036898, 13376.001268149132, 13468.93265533666, 13517.662058448224, 13774.862251377357, 14262.857371426568, 13142.868571314164, 13470.393832277376, 13654.658633534242, 13899.0, 14172.29138543048, 12576.119671622899, 12580.182288151607, 13349.399277032362, 13374.197548147142, 13922.72154556883, 11050.281731687415, 11312.0, 11329.0, 11457.197996140523, 11827.112966527373, 11271.830922536004, 11370.829437558608, 11469.827952580885, 11509.482073306554, 11719.472623732123], "value": 7448.964551268436, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 127.0, 176.0, 128.0, 132.0, 133.0, 127.0, 154.0, 129.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 171.0, 163.0, 166.0, 164.0, 164.0, 165.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 112.0, 77.0, 77.0, 79.0, 78.0, 101.0, 78.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 124.0, 82.0, 84.0, 82.0, 103.0, 83.0, 82.0, 105.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 119.0, 118.0, 118.0, 117.0, 119.0, 119.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 149.0, 148.0, 148.0, 147.0, 149.0, 149.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 56.0, 55.0, 53.0, 56.0, 55.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 63.0, 61.0, 62.0, 63.0, 64.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 86.0, 80.0, 82.0, 80.0, 80.0, 81.0, 82.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 148.0, 135.0, 135.0, 142.0, 140.0, 144.0, 141.0, 178.0, 141.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 167.0, 167.0, 173.0, 170.0, 175.0, 172.0, 171.0, 171.0, 172.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 69.0, 68.0, 66.0, 68.0, 67.0, 66.0, 66.0, 66.0], "value": 67.3, "unit": "score"}]}]} 23:37:27 INFO - Return code: 0 23:37:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:37:27 ERROR - # TBPL SUCCESS # 23:37:27 INFO - Running post-action listener: _resource_record_post_action 23:37:27 INFO - [mozharness: 2016-10-04 06:37:27.893459Z] Finished run-tests step (success) 23:37:27 INFO - Running post-run listener: _resource_record_post_run 23:37:27 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 392912896; Read time: 292; Write time: 362824 23:37:27 INFO - TinderboxPrint: CPU usage
13.4% 23:37:27 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 292 23:37:27 INFO - TinderboxPrint: I/O write bytes / time
392,912,896 / 362,824 23:37:27 INFO - TinderboxPrint: CPU idle
8,253.5 (86.5%) 23:37:27 INFO - TinderboxPrint: CPU user
1,218.1 (12.8%) 23:37:27 INFO - TinderboxPrint: Swap in / out
0 / 0 23:37:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103788544; Read time: 0; Write time: 141040 23:37:27 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289124352; Read time: 260; Write time: 221784 23:37:28 INFO - Running post-run listener: _upload_blobber_files 23:37:28 INFO - Blob upload gear active. 23:37:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:37:28 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 23:37:28 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:37:28 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:37:28 INFO - (blobuploader) - INFO - Open directory for files ... 23:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:31 INFO - (blobuploader) - INFO - Done attempting. 23:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:37:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:34 INFO - (blobuploader) - INFO - Done attempting. 23:37:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:37:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:37:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:35 INFO - (blobuploader) - INFO - Done attempting. 23:37:35 INFO - (blobuploader) - INFO - Iteration through files over. 23:37:35 INFO - Return code: 0 23:37:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:37:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:37:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f111cf179a8ca014f68977408330046301ff357d1b184be27687b884b08688f41d36f20df5441015fb7cbf54ff01aa421285e01643b9e5a20005f193d8ef115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ab7a949c44d11dc03de90037889a8b2d3a2b794df521c78dccf59a122c6e3fbb1b5eefb1a2b25c95c7fb7ad8cf7be5e71de0c56ea52bce030eb42c1f1484ee4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63562c6f2118fd9dda332332daf3d531612a7b12da143ee1b7969daaa4fb663243353426b5e8b1dd87411a16a7505644b2b59f33d463b08bca56ebbdfbef5c6d"} 23:37:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:37:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:37:35 INFO - Contents: 23:37:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f111cf179a8ca014f68977408330046301ff357d1b184be27687b884b08688f41d36f20df5441015fb7cbf54ff01aa421285e01643b9e5a20005f193d8ef115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ab7a949c44d11dc03de90037889a8b2d3a2b794df521c78dccf59a122c6e3fbb1b5eefb1a2b25c95c7fb7ad8cf7be5e71de0c56ea52bce030eb42c1f1484ee4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63562c6f2118fd9dda332332daf3d531612a7b12da143ee1b7969daaa4fb663243353426b5e8b1dd87411a16a7505644b2b59f33d463b08bca56ebbdfbef5c6d"} 23:37:35 INFO - Running post-run listener: copy_logs_to_upload_dir 23:37:35 INFO - Copying logs to upload dir... 23:37:35 INFO - mkdir: /builds/slave/test/build/upload/logs 23:37:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.826343 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-03 23:37:34.928292) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 23:37:34.932204) ========= 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=52faae308a556c440401f8e5000001e8-1475561813.17947-638106078 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-Inbound/sha512/4f111cf179a8ca014f68977408330046301ff357d1b184be27687b884b08688f41d36f20df5441015fb7cbf54ff01aa421285e01643b9e5a20005f193d8ef115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ab7a949c44d11dc03de90037889a8b2d3a2b794df521c78dccf59a122c6e3fbb1b5eefb1a2b25c95c7fb7ad8cf7be5e71de0c56ea52bce030eb42c1f1484ee4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63562c6f2118fd9dda332332daf3d531612a7b12da143ee1b7969daaa4fb663243353426b5e8b1dd87411a16a7505644b2b59f33d463b08bca56ebbdfbef5c6d"} build_url:https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/Tk-zlMfsQBq1pDxebIWyFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f111cf179a8ca014f68977408330046301ff357d1b184be27687b884b08688f41d36f20df5441015fb7cbf54ff01aa421285e01643b9e5a20005f193d8ef115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ab7a949c44d11dc03de90037889a8b2d3a2b794df521c78dccf59a122c6e3fbb1b5eefb1a2b25c95c7fb7ad8cf7be5e71de0c56ea52bce030eb42c1f1484ee4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/63562c6f2118fd9dda332332daf3d531612a7b12da143ee1b7969daaa4fb663243353426b5e8b1dd87411a16a7505644b2b59f33d463b08bca56ebbdfbef5c6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 23:37:34.961278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:37:34.961599) ========= 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=52faae308a556c440401f8e5000001e8-1475561813.17947-638106078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 23:37:35.044880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 23:37:35.045224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 23:37:35.045612) ========= ========= Total master_lag: 0.16 =========