builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1482339759.37 results: success (0) buildid: 20161221065215 builduid: 0fa23d49e6de4c24b2197daff3ae89bd revision: e6ec59a1128a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:39.375081) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:39.375628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:39.375913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:39.391286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:39.391753) ========= 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=652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 09:02:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-12-21 09:02:39 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106873 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:39.513088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:39.513511) ========= 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=652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014893 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:39.563039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 09:02:39.563422) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e6ec59a1128a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e6ec59a1128a --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=652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 09:02:39,943 Setting DEBUG logging. 2016-12-21 09:02:39,943 attempt 1/10 2016-12-21 09:02:39,943 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e6ec59a1128a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 09:02:40,537 unpacking tar archive at: mozilla-aurora-e6ec59a1128a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.994617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 09:02:40.571600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:40.571919) ========= script_repo_revision: e6ec59a1128a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:40.572463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:40.572729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 09:02:40.583030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-21 09:02:40.583347) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:02:41 INFO - MultiFileLogger online at 20161221 09:02:41 in /builds/slave/test 09:02:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:02:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:02:41 INFO - {'append_to_log': False, 09:02:41 INFO - 'base_work_dir': '/builds/slave/test', 09:02:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:02:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:02:41 INFO - 'branch': 'Mozilla-Aurora', 09:02:41 INFO - 'buildbot_json_path': 'buildprops.json', 09:02:41 INFO - 'config_files': ('talos/linux_config.py',), 09:02:41 INFO - 'default_actions': ('clobber', 09:02:41 INFO - 'read-buildbot-config', 09:02:41 INFO - 'download-and-extract', 09:02:41 INFO - 'populate-webroot', 09:02:41 INFO - 'create-virtualenv', 09:02:41 INFO - 'install', 09:02:41 INFO - 'run-tests'), 09:02:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:02:41 INFO - 'download_minidump_stackwalk': True, 09:02:41 INFO - 'download_symbols': 'ondemand', 09:02:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:02:41 INFO - 'tooltool.py': '/tools/tooltool.py', 09:02:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:02:41 INFO - '/tools/misc-python/virtualenv.py')}, 09:02:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:02:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:02:41 INFO - 'installer_path': 'installer.exe', 09:02:41 INFO - 'log_level': 'info', 09:02:41 INFO - 'log_name': 'talos', 09:02:41 INFO - 'log_to_console': True, 09:02:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:02:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:02:41 INFO - 'opt_config_files': (), 09:02:41 INFO - 'pip_index': False, 09:02:41 INFO - 'sps_profile': False, 09:02:41 INFO - 'sps_profile_interval': 0, 09:02:41 INFO - 'suite': 'dromaeojs-e10s', 09:02:41 INFO - 'system_bits': '32', 09:02:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:02:41 INFO - 'title': 'talos-linux64-ix-046', 09:02:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:02:41 INFO - 'use_talos_json': True, 09:02:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:02:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:02:41 INFO - 'work_dir': 'build'} 09:02:41 INFO - [mozharness: 2016-12-21 17:02:41.053747Z] Running clobber step. 09:02:41 INFO - Running pre-action listener: _resource_record_pre_action 09:02:41 INFO - Running main action method: clobber 09:02:41 INFO - rmtree: /builds/slave/test/build 09:02:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:02:41 INFO - Running post-action listener: _resource_record_post_action 09:02:41 INFO - [mozharness: 2016-12-21 17:02:41.577647Z] Finished clobber step (success) 09:02:41 INFO - [mozharness: 2016-12-21 17:02:41.577747Z] Running read-buildbot-config step. 09:02:41 INFO - Running pre-action listener: _resource_record_pre_action 09:02:41 INFO - Running main action method: read_buildbot_config 09:02:41 INFO - Using buildbot properties: 09:02:41 INFO - { 09:02:41 INFO - "project": "", 09:02:41 INFO - "product": "firefox", 09:02:41 INFO - "script_repo_revision": "production", 09:02:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:02:41 INFO - "repository": "", 09:02:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:02:41 INFO - "buildid": "20161221065215", 09:02:41 INFO - "stage_platform": "linux64-pgo", 09:02:41 INFO - "basedir": "/builds/slave/test", 09:02:41 INFO - "nightly_build": "True", 09:02:41 INFO - "buildnumber": 691, 09:02:41 INFO - "slavename": "talos-linux64-ix-046", 09:02:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:02:41 INFO - "platform": "ubuntu64_hw", 09:02:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:02:41 INFO - "branch": "mozilla-aurora", 09:02:41 INFO - "repo_path": "releases/mozilla-aurora", 09:02:41 INFO - "revision": "e6ec59a1128a", 09:02:41 INFO - "pgo_build": "True", 09:02:41 INFO - "builduid": "0fa23d49e6de4c24b2197daff3ae89bd", 09:02:41 INFO - "slavebuilddir": "test" 09:02:41 INFO - } 09:02:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:02:41 INFO - Running post-action listener: _resource_record_post_action 09:02:41 INFO - [mozharness: 2016-12-21 17:02:41.580235Z] Finished read-buildbot-config step (success) 09:02:41 INFO - [mozharness: 2016-12-21 17:02:41.580323Z] Running download-and-extract step. 09:02:41 INFO - Running pre-action listener: _resource_record_pre_action 09:02:41 INFO - Running main action method: download_and_extract 09:02:41 INFO - mkdir: /builds/slave/test/build/tests 09:02:41 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')]} 09:02:41 INFO - trying https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:02:41 INFO - Downloading https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:02:42 INFO - Downloaded 1361 bytes. 09:02:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:02:42 INFO - Using the following test package requirements: 09:02:42 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:02:42 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:02:42 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:02:42 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:42 INFO - u'jsshell-linux-x86_64.zip'], 09:02:42 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:02:42 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:02:42 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:02:42 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:02:42 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:02:42 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:02:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:02:42 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:02:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:02:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:02:42 INFO - Fetch https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:02:42 INFO - Http code: 200 09:02:42 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 09:02:42 INFO - x-amz-cf-id: kMpji9AJt8h6xX-AZergpXm0Ba4ruFqfCVzx7HFT529251uXFFUJHw== 09:02:42 INFO - x-amz-version-id: .Hx1ThtRMiVs8UPrJlEa1zK_z_CMvAuz 09:02:43 INFO - Expected file size: 21940159 09:02:43 INFO - Obtained file size: 21940159 09:02:47 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:02:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:02:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:02:47 INFO - Fetch https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:02:47 INFO - Http code: 200 09:02:47 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 09:02:47 INFO - x-amz-cf-id: _A0hA9cNe-a3lGxFVw54tzaC4lHj4rAS4-zOCdbPb1CprkoG7SwSYg== 09:02:47 INFO - x-amz-version-id: .Hx1ThtRMiVs8UPrJlEa1zK_z_CMvAuz 09:02:47 INFO - Expected file size: 21940159 09:02:47 INFO - Obtained file size: 21940159 09:02:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:02:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:02:52 INFO - Fetch https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:02:52 INFO - Http code: 200 09:02:52 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 09:02:52 INFO - x-amz-cf-id: 96fH_p_1dBQzupAcOKQhn6xxCxAQeNvT6GgfxU8nVBXItnaMqOK9YQ== 09:02:52 INFO - x-amz-version-id: EcVDie.x6r0A5B0hWIfsaHjbOuN8evq2 09:02:53 INFO - Expected file size: 14409038 09:02:53 INFO - Obtained file size: 14409038 09:02:53 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')]} 09:02:53 INFO - trying https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:02:53 INFO - Downloading https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:02:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:02:56 INFO - Downloaded 63976572 bytes. 09:02:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:02:56 INFO - mkdir: /builds/slave/test/properties 09:02:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:02:56 INFO - Writing to file /builds/slave/test/properties/build_url 09:02:56 INFO - Contents: 09:02:56 INFO - build_url:https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:02:57 INFO - Running post-action listener: _resource_record_post_action 09:02:57 INFO - Running post-action listener: set_extra_try_arguments 09:02:57 INFO - [mozharness: 2016-12-21 17:02:57.211136Z] Finished download-and-extract step (success) 09:02:57 INFO - [mozharness: 2016-12-21 17:02:57.211364Z] Running populate-webroot step. 09:02:57 INFO - Running pre-action listener: _resource_record_pre_action 09:02:57 INFO - Running main action method: populate_webroot 09:02:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:02:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:02:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:02:57 INFO - '--tppagecycles', 09:02:57 INFO - '7'], 09:02:57 INFO - 'tests': ['tsvgm']}}, 09:02:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:02:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:02:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:02:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:02:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:57 INFO - 'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:57 INFO - 'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['damp', 'tps']}, 09:02:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:57 INFO - 'tests': ['damp', 'tps']}, 09:02:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['dromaeo_dom']}, 09:02:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:02:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['basic_compositor_video']}, 09:02:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:02:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['a11yr', 09:02:57 INFO - 'ts_paint', 09:02:57 INFO - 'tpaint', 09:02:57 INFO - 'sessionrestore', 09:02:57 INFO - 'sessionrestore_no_auto_restore', 09:02:57 INFO - 'tabpaint']}, 09:02:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:02:57 INFO - 'ts_paint', 09:02:57 INFO - 'tpaint', 09:02:57 INFO - 'sessionrestore', 09:02:57 INFO - 'sessionrestore_no_auto_restore', 09:02:57 INFO - 'tabpaint']}, 09:02:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:02:57 INFO - 'ts_paint', 09:02:57 INFO - 'tpaint', 09:02:57 INFO - 'sessionrestore', 09:02:57 INFO - 'sessionrestore_no_auto_restore', 09:02:57 INFO - 'tabpaint']}, 09:02:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:02:57 INFO - 'ts_paint', 09:02:57 INFO - 'tpaint', 09:02:57 INFO - 'sessionrestore', 09:02:57 INFO - 'sessionrestore_no_auto_restore', 09:02:57 INFO - 'tabpaint']}, 09:02:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['a11yr', 09:02:57 INFO - 'ts_paint', 09:02:57 INFO - 'tpaint', 09:02:57 INFO - 'sessionrestore', 09:02:57 INFO - 'sessionrestore_no_auto_restore', 09:02:57 INFO - 'tabpaint']}, 09:02:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['a11yr', 09:02:57 INFO - 'ts_paint', 09:02:57 INFO - 'tpaint', 09:02:57 INFO - 'sessionrestore', 09:02:57 INFO - 'sessionrestore_no_auto_restore', 09:02:57 INFO - 'tabpaint']}, 09:02:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['tsvgx', 09:02:57 INFO - 'tsvgr_opacity', 09:02:57 INFO - 'tart', 09:02:57 INFO - 'tscrollx', 09:02:57 INFO - 'cart']}, 09:02:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:02:57 INFO - 'tsvgr_opacity', 09:02:57 INFO - 'tart', 09:02:57 INFO - 'tscrollx', 09:02:57 INFO - 'cart']}, 09:02:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:57 INFO - 'talos_options': ['--disable-e10s'], 09:02:57 INFO - 'tests': ['tp5o']}, 09:02:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:57 INFO - 'tests': ['tp5o']}, 09:02:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:57 INFO - 'talos_options': ['--disable-e10s', 09:02:57 INFO - '--xperf_path', 09:02:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:57 INFO - 'tests': ['tp5n']}, 09:02:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:57 INFO - 'talos_options': ['--xperf_path', 09:02:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:57 INFO - 'tests': ['tp5n']}}, 09:02:57 INFO - 'talos.zip': {'path': '', 09:02:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:02:57 INFO - Running post-action listener: _resource_record_post_action 09:02:57 INFO - [mozharness: 2016-12-21 17:02:57.233416Z] Finished populate-webroot step (success) 09:02:57 INFO - [mozharness: 2016-12-21 17:02:57.233505Z] Running create-virtualenv step. 09:02:57 INFO - Running pre-action listener: _resource_record_pre_action 09:02:57 INFO - Running main action method: create_virtualenv 09:02:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:02:57 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 09:02:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:02:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:02:57 INFO - Using real prefix '/usr' 09:02:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:02:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:02:59 INFO - Installing pip.................done. 09:02:59 INFO - Return code: 0 09:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:03:00 INFO - Reading from file tmpfile_stdout 09:03:00 INFO - Output received: 09:03:00 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) 09:03:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:03:00 INFO - Using env: {'DISPLAY': ':0', 09:03:00 INFO - 'HOME': '/home/cltbld', 09:03:00 INFO - 'LANG': 'en_US.UTF-8', 09:03:00 INFO - 'LANGUAGE': 'en_US:en', 09:03:00 INFO - 'LOGNAME': 'cltbld', 09:03:00 INFO - 'MAIL': '/var/mail/cltbld', 09:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:00 INFO - 'MOZ_NO_REMOTE': '1', 09:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:00 INFO - 'NO_EM_RESTART': '1', 09:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:00 INFO - 'PWD': '/builds/slave/test', 09:03:00 INFO - 'SHELL': '/bin/bash', 09:03:00 INFO - 'SHLVL': '1', 09:03:00 INFO - 'TERM': 'linux', 09:03:00 INFO - 'TMOUT': '86400', 09:03:00 INFO - 'USER': 'cltbld', 09:03:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:00 INFO - '_': '/tools/buildbot/bin/python'} 09:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:00 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 09:03:00 INFO - Cleaning up... 09:03:00 INFO - Return code: 0 09:03:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:03:00 INFO - Using env: {'DISPLAY': ':0', 09:03:00 INFO - 'HOME': '/home/cltbld', 09:03:00 INFO - 'LANG': 'en_US.UTF-8', 09:03:00 INFO - 'LANGUAGE': 'en_US:en', 09:03:00 INFO - 'LOGNAME': 'cltbld', 09:03:00 INFO - 'MAIL': '/var/mail/cltbld', 09:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:00 INFO - 'MOZ_NO_REMOTE': '1', 09:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:00 INFO - 'NO_EM_RESTART': '1', 09:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:00 INFO - 'PWD': '/builds/slave/test', 09:03:00 INFO - 'SHELL': '/bin/bash', 09:03:00 INFO - 'SHLVL': '1', 09:03:00 INFO - 'TERM': 'linux', 09:03:00 INFO - 'TMOUT': '86400', 09:03:00 INFO - 'USER': 'cltbld', 09:03:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:00 INFO - '_': '/tools/buildbot/bin/python'} 09:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:00 INFO - Downloading/unpacking psutil>=3.1.1 09:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:02 INFO - Installing collected packages: psutil 09:03:02 INFO - Running setup.py install for psutil 09:03:02 INFO - building 'psutil._psutil_linux' extension 09:03:02 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 09:03:02 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 09:03:02 INFO - building 'psutil._psutil_posix' extension 09:03:02 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 09:03:03 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 09:03:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:03 INFO - Successfully installed psutil 09:03:03 INFO - Cleaning up... 09:03:03 INFO - Return code: 0 09:03:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:03:03 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')]} 09:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:03 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')]} 09:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:03 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 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03:03 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 09:03:03 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 09:03:03 INFO - Using env: {'DISPLAY': ':0', 09:03:03 INFO - 'HOME': '/home/cltbld', 09:03:03 INFO - 'LANG': 'en_US.UTF-8', 09:03:03 INFO - 'LANGUAGE': 'en_US:en', 09:03:03 INFO - 'LOGNAME': 'cltbld', 09:03:03 INFO - 'MAIL': '/var/mail/cltbld', 09:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:03 INFO - 'MOZ_NO_REMOTE': '1', 09:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:03 INFO - 'NO_EM_RESTART': '1', 09:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:03 INFO - 'PWD': '/builds/slave/test', 09:03:03 INFO - 'SHELL': '/bin/bash', 09:03:03 INFO - 'SHLVL': '1', 09:03:03 INFO - 'TERM': 'linux', 09:03:03 INFO - 'TMOUT': '86400', 09:03:03 INFO - 'USER': 'cltbld', 09:03:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:03 INFO - '_': '/tools/buildbot/bin/python'} 09:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:03:05 INFO - Installing collected packages: mozsystemmonitor 09:03:05 INFO - Running setup.py install for mozsystemmonitor 09:03:05 INFO - Successfully installed mozsystemmonitor 09:03:05 INFO - Cleaning up... 09:03:05 INFO - Return code: 0 09:03:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:05 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 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03:05 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 09:03:05 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 09:03:05 INFO - Using env: {'DISPLAY': ':0', 09:03:05 INFO - 'HOME': '/home/cltbld', 09:03:05 INFO - 'LANG': 'en_US.UTF-8', 09:03:05 INFO - 'LANGUAGE': 'en_US:en', 09:03:05 INFO - 'LOGNAME': 'cltbld', 09:03:05 INFO - 'MAIL': '/var/mail/cltbld', 09:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:05 INFO - 'MOZ_NO_REMOTE': '1', 09:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:05 INFO - 'NO_EM_RESTART': '1', 09:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:05 INFO - 'PWD': '/builds/slave/test', 09:03:05 INFO - 'SHELL': '/bin/bash', 09:03:05 INFO - 'SHLVL': '1', 09:03:05 INFO - 'TERM': 'linux', 09:03:05 INFO - 'TMOUT': '86400', 09:03:05 INFO - 'USER': 'cltbld', 09:03:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:05 INFO - '_': '/tools/buildbot/bin/python'} 09:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:05 INFO - Downloading/unpacking jsonschema==2.5.1 09:03:05 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 09:03:05 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 09:03:05 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 09:03:05 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 09:03:05 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 09:03:05 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 09:03:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:03:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:03:07 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 09:03:07 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 09:03:07 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 09:03:07 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 09:03:07 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 09:03:07 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 09:03:08 INFO - Downloading functools32-3.2.3-2.tar.gz 09:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:03:08 INFO - warning: no files found matching '*.txt' 09:03:08 INFO - no previously-included directories found matching 'build' 09:03:08 INFO - no previously-included directories found matching 'dist' 09:03:08 INFO - no previously-included directories found matching '.git*' 09:03:08 INFO - Installing collected packages: jsonschema, functools32 09:03:08 INFO - Running setup.py install for functools32 09:03:08 INFO - warning: no files found matching '*.txt' 09:03:08 INFO - no previously-included directories found matching 'build' 09:03:08 INFO - no previously-included directories found matching 'dist' 09:03:08 INFO - no previously-included directories found matching '.git*' 09:03:08 INFO - Successfully installed jsonschema functools32 09:03:08 INFO - Cleaning up... 09:03:08 INFO - Return code: 0 09:03:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:08 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 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03:08 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 09:03:08 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 09:03:08 INFO - Using env: {'DISPLAY': ':0', 09:03:08 INFO - 'HOME': '/home/cltbld', 09:03:08 INFO - 'LANG': 'en_US.UTF-8', 09:03:08 INFO - 'LANGUAGE': 'en_US:en', 09:03:08 INFO - 'LOGNAME': 'cltbld', 09:03:08 INFO - 'MAIL': '/var/mail/cltbld', 09:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:08 INFO - 'MOZ_NO_REMOTE': '1', 09:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:08 INFO - 'NO_EM_RESTART': '1', 09:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:08 INFO - 'PWD': '/builds/slave/test', 09:03:08 INFO - 'SHELL': '/bin/bash', 09:03:08 INFO - 'SHLVL': '1', 09:03:08 INFO - 'TERM': 'linux', 09:03:08 INFO - 'TMOUT': '86400', 09:03:08 INFO - 'USER': 'cltbld', 09:03:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:08 INFO - '_': '/tools/buildbot/bin/python'} 09:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:03:08 INFO - Cleaning up... 09:03:08 INFO - Return code: 0 09:03:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:08 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 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03:08 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 09:03:08 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 09:03:08 INFO - Using env: {'DISPLAY': ':0', 09:03:08 INFO - 'HOME': '/home/cltbld', 09:03:08 INFO - 'LANG': 'en_US.UTF-8', 09:03:08 INFO - 'LANGUAGE': 'en_US:en', 09:03:08 INFO - 'LOGNAME': 'cltbld', 09:03:08 INFO - 'MAIL': '/var/mail/cltbld', 09:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:08 INFO - 'MOZ_NO_REMOTE': '1', 09:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:08 INFO - 'NO_EM_RESTART': '1', 09:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:08 INFO - 'PWD': '/builds/slave/test', 09:03:08 INFO - 'SHELL': '/bin/bash', 09:03:08 INFO - 'SHLVL': '1', 09:03:08 INFO - 'TERM': 'linux', 09:03:08 INFO - 'TMOUT': '86400', 09:03:08 INFO - 'USER': 'cltbld', 09:03:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:08 INFO - '_': '/tools/buildbot/bin/python'} 09:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:08 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:08 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 09:03:08 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 09:03:08 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 09:03:08 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 09:03:08 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 09:03:08 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 09:03:10 INFO - Downloading blobuploader-1.2.4.tar.gz 09:03:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:03:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:03:10 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 09:03:10 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 09:03:10 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 09:03:10 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 09:03:10 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 09:03:10 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 09:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:03:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:03:11 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 09:03:11 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 09:03:11 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 09:03:11 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 09:03:11 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 09:03:11 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 09:03:11 INFO - Downloading docopt-0.6.1.tar.gz 09:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:03:11 INFO - Installing collected packages: blobuploader, requests, docopt 09:03:11 INFO - Running setup.py install for blobuploader 09:03:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:03:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:03:11 INFO - Running setup.py install for requests 09:03:12 INFO - Running setup.py install for docopt 09:03:12 INFO - Successfully installed blobuploader requests docopt 09:03:12 INFO - Cleaning up... 09:03:12 INFO - Return code: 0 09:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:12 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 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03:12 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 09:03:12 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 09:03:12 INFO - Using env: {'DISPLAY': ':0', 09:03:12 INFO - 'HOME': '/home/cltbld', 09:03:12 INFO - 'LANG': 'en_US.UTF-8', 09:03:12 INFO - 'LANGUAGE': 'en_US:en', 09:03:12 INFO - 'LOGNAME': 'cltbld', 09:03:12 INFO - 'MAIL': '/var/mail/cltbld', 09:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:12 INFO - 'MOZ_NO_REMOTE': '1', 09:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:12 INFO - 'NO_EM_RESTART': '1', 09:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:12 INFO - 'PWD': '/builds/slave/test', 09:03:12 INFO - 'SHELL': '/bin/bash', 09:03:12 INFO - 'SHLVL': '1', 09:03:12 INFO - 'TERM': 'linux', 09:03:12 INFO - 'TMOUT': '86400', 09:03:12 INFO - 'USER': 'cltbld', 09:03:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:12 INFO - '_': '/tools/buildbot/bin/python'} 09:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:12 INFO - Running setup.py (path:/tmp/pip-7UYb83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:12 INFO - Running setup.py (path:/tmp/pip-otPqzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:12 INFO - Running setup.py (path:/tmp/pip-48D2s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:12 INFO - Running setup.py (path:/tmp/pip-cR16wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:12 INFO - Running setup.py (path:/tmp/pip-rK8fDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:12 INFO - Running setup.py (path:/tmp/pip-DBFDJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:12 INFO - Running setup.py (path:/tmp/pip-_5_8TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:12 INFO - Running setup.py (path:/tmp/pip-q89MyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:13 INFO - Running setup.py (path:/tmp/pip-nAXgUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:13 INFO - Running setup.py (path:/tmp/pip-KmXH6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:13 INFO - Running setup.py (path:/tmp/pip-wrjZH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:13 INFO - Running setup.py (path:/tmp/pip-jQqUmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:13 INFO - Running setup.py (path:/tmp/pip-PPndNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:13 INFO - Running setup.py (path:/tmp/pip-oA9bad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:13 INFO - Running setup.py (path:/tmp/pip-SvTbHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:13 INFO - Running setup.py (path:/tmp/pip-SeP2B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:13 INFO - Running setup.py (path:/tmp/pip-l4oxsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:13 INFO - Running setup.py install for manifestparser 09:03:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:03:13 INFO - Running setup.py install for mozcrash 09:03:13 INFO - Running setup.py install for mozdebug 09:03:13 INFO - Running setup.py install for mozdevice 09:03:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Running setup.py install for mozfile 09:03:14 INFO - Running setup.py install for mozhttpd 09:03:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Running setup.py install for mozinfo 09:03:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Running setup.py install for mozInstall 09:03:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Running setup.py install for mozleak 09:03:14 INFO - Running setup.py install for mozlog 09:03:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Running setup.py install for moznetwork 09:03:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:03:14 INFO - Running setup.py install for mozprocess 09:03:14 INFO - Running setup.py install for mozprofile 09:03:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:03:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:03:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:03:15 INFO - Running setup.py install for mozrunner 09:03:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:03:15 INFO - Running setup.py install for mozscreenshot 09:03:15 INFO - Running setup.py install for moztest 09:03:15 INFO - Running setup.py install for mozversion 09:03:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:03:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:15 INFO - Cleaning up... 09:03:15 INFO - Return code: 0 09:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:15 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 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03:15 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 09:03:15 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 09:03:15 INFO - Using env: {'DISPLAY': ':0', 09:03:15 INFO - 'HOME': '/home/cltbld', 09:03:15 INFO - 'LANG': 'en_US.UTF-8', 09:03:15 INFO - 'LANGUAGE': 'en_US:en', 09:03:15 INFO - 'LOGNAME': 'cltbld', 09:03:15 INFO - 'MAIL': '/var/mail/cltbld', 09:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:15 INFO - 'MOZ_NO_REMOTE': '1', 09:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:15 INFO - 'NO_EM_RESTART': '1', 09:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:15 INFO - 'PWD': '/builds/slave/test', 09:03:15 INFO - 'SHELL': '/bin/bash', 09:03:15 INFO - 'SHLVL': '1', 09:03:15 INFO - 'TERM': 'linux', 09:03:15 INFO - 'TMOUT': '86400', 09:03:15 INFO - 'USER': 'cltbld', 09:03:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:15 INFO - '_': '/tools/buildbot/bin/python'} 09:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:15 INFO - Running setup.py (path:/tmp/pip-BvbQF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:15 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)) 09:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:15 INFO - Running setup.py (path:/tmp/pip-GPqOFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:15 INFO - Running setup.py (path:/tmp/pip-CfCqY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:15 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)) 09:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:15 INFO - Running setup.py (path:/tmp/pip-nyc2JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:15 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)) 09:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:15 INFO - Running setup.py (path:/tmp/pip-J_HnNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:16 INFO - Running setup.py (path:/tmp/pip-gLoLUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:16 INFO - Running setup.py (path:/tmp/pip-B1jtXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:16 INFO - Running setup.py (path:/tmp/pip-y6DZ8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:16 INFO - Running setup.py (path:/tmp/pip-JKGI8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:16 INFO - Running setup.py (path:/tmp/pip-zhFcKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:16 INFO - Running setup.py (path:/tmp/pip-fVJLE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:16 INFO - Running setup.py (path:/tmp/pip-G61VBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:16 INFO - Running setup.py (path:/tmp/pip-0nOfDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:16 INFO - Running setup.py (path:/tmp/pip-6rp1O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:16 INFO - Running setup.py (path:/tmp/pip-SjKnPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:16 INFO - Running setup.py (path:/tmp/pip-fOVE61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:16 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)) 09:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:16 INFO - Running setup.py (path:/tmp/pip-dZjDxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:16 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)) 09:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:03:16 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)) 09:03:16 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)) 09:03:16 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)) 09:03:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:16 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 09:03:16 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 09:03:16 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 09:03:16 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 09:03:16 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 09:03:16 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 09:03:18 INFO - Downloading blessings-1.6.tar.gz 09:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:18 INFO - Installing collected packages: blessings 09:03:18 INFO - Running setup.py install for blessings 09:03:19 INFO - Successfully installed blessings 09:03:19 INFO - Cleaning up... 09:03:19 INFO - Return code: 0 09:03:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:03:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:19 INFO - Reading from file tmpfile_stdout 09:03:19 INFO - Current package versions: 09:03:19 INFO - argparse == 1.2.1 09:03:19 INFO - blessings == 1.6 09:03:19 INFO - blobuploader == 1.2.4 09:03:19 INFO - docopt == 0.6.1 09:03:19 INFO - functools32 == 3.2.3-2 09:03:19 INFO - jsonschema == 2.5.1 09:03:19 INFO - manifestparser == 1.1 09:03:19 INFO - mozInstall == 1.12 09:03:19 INFO - mozcrash == 1.0 09:03:19 INFO - mozdebug == 0.1 09:03:19 INFO - mozdevice == 0.48 09:03:19 INFO - mozfile == 1.2 09:03:19 INFO - mozhttpd == 0.7 09:03:19 INFO - mozinfo == 0.9 09:03:19 INFO - mozleak == 0.1 09:03:19 INFO - mozlog == 3.4 09:03:19 INFO - moznetwork == 0.27 09:03:19 INFO - mozprocess == 0.23 09:03:19 INFO - mozprofile == 0.28 09:03:19 INFO - mozrunner == 6.13 09:03:19 INFO - mozscreenshot == 0.1 09:03:19 INFO - mozsystemmonitor == 0.3 09:03:19 INFO - moztest == 0.7 09:03:19 INFO - mozversion == 1.4 09:03:19 INFO - psutil == 3.1.1 09:03:19 INFO - requests == 1.2.3 09:03:19 INFO - wsgiref == 0.1.2 09:03:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:19 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 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03:19 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 09:03:19 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 09:03:19 INFO - Using env: {'DISPLAY': ':0', 09:03:19 INFO - 'HOME': '/home/cltbld', 09:03:19 INFO - 'LANG': 'en_US.UTF-8', 09:03:19 INFO - 'LANGUAGE': 'en_US:en', 09:03:19 INFO - 'LOGNAME': 'cltbld', 09:03:19 INFO - 'MAIL': '/var/mail/cltbld', 09:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:19 INFO - 'MOZ_NO_REMOTE': '1', 09:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:19 INFO - 'NO_EM_RESTART': '1', 09:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:19 INFO - 'PWD': '/builds/slave/test', 09:03:19 INFO - 'SHELL': '/bin/bash', 09:03:19 INFO - 'SHLVL': '1', 09:03:19 INFO - 'TERM': 'linux', 09:03:19 INFO - 'TMOUT': '86400', 09:03:19 INFO - 'USER': 'cltbld', 09:03:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:19 INFO - '_': '/tools/buildbot/bin/python'} 09:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:19 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)) 09:03:19 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)) 09:03:19 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)) 09:03:19 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)) 09:03:19 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)) 09:03:19 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)) 09:03:19 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)) 09:03:19 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)) 09:03:19 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)) 09:03:19 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)) 09:03:19 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)) 09:03:19 INFO - Cleaning up... 09:03:19 INFO - Return code: 0 09:03:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7394943f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', '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 09:03: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', 'jsonschema'] in /builds/slave/test/build 09:03: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 jsonschema 09:03:19 INFO - Using env: {'DISPLAY': ':0', 09:03:19 INFO - 'HOME': '/home/cltbld', 09:03:19 INFO - 'LANG': 'en_US.UTF-8', 09:03:19 INFO - 'LANGUAGE': 'en_US:en', 09:03:19 INFO - 'LOGNAME': 'cltbld', 09:03:19 INFO - 'MAIL': '/var/mail/cltbld', 09:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:19 INFO - 'MOZ_NO_REMOTE': '1', 09:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:19 INFO - 'NO_EM_RESTART': '1', 09:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:19 INFO - 'PWD': '/builds/slave/test', 09:03:19 INFO - 'SHELL': '/bin/bash', 09:03:19 INFO - 'SHLVL': '1', 09:03:19 INFO - 'TERM': 'linux', 09:03:19 INFO - 'TMOUT': '86400', 09:03:19 INFO - 'USER': 'cltbld', 09:03:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:19 INFO - '_': '/tools/buildbot/bin/python'} 09:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:03:19 INFO - Cleaning up... 09:03:19 INFO - Return code: 0 09:03:19 INFO - Running post-action listener: _resource_record_post_action 09:03:19 INFO - Running post-action listener: _start_resource_monitoring 09:03:19 INFO - Starting resource monitoring. 09:03:19 INFO - [mozharness: 2016-12-21 17:03:19.865979Z] Finished create-virtualenv step (success) 09:03:19 INFO - [mozharness: 2016-12-21 17:03:19.866442Z] Running install step. 09:03:19 INFO - Running pre-action listener: _resource_record_pre_action 09:03:19 INFO - Running main action method: install 09:03:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:20 INFO - Reading from file tmpfile_stdout 09:03:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:03:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:03:20 INFO - Reading from file tmpfile_stdout 09:03:20 INFO - Output received: 09:03:20 INFO - Usage: mozinstall [options] installer 09:03:20 INFO - Options: 09:03:20 INFO - -h, --help show this help message and exit 09:03:20 INFO - -d DEST, --destination=DEST 09:03:20 INFO - Directory to install application into. [default: 09:03:20 INFO - "/builds/slave/test"] 09:03:20 INFO - --app=APP Application being installed. [default: firefox] 09:03:20 INFO - mkdir: /builds/slave/test/build/application 09:03:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:03:36 INFO - Reading from file tmpfile_stdout 09:03:36 INFO - Output received: 09:03:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:03:36 INFO - Running post-action listener: _resource_record_post_action 09:03:36 INFO - [mozharness: 2016-12-21 17:03:36.038933Z] Finished install step (success) 09:03:36 INFO - [mozharness: 2016-12-21 17:03:36.039177Z] Running run-tests step. 09:03:36 INFO - Running pre-action listener: _resource_record_pre_action 09:03:36 INFO - Running main action method: run_tests 09:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:03:36 INFO - Python 2.7.3 09:03:36 INFO - Return code: 0 09:03:36 INFO - grabbing minidump binary from tooltool 09:03:36 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')]} 09:03:36 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 0x1c58f60>, '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 0x1c59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c5a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:03:36 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 09:03:36 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 09:03:36 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 09:03:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:03:36 INFO - Return code: 0 09:03:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:03:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:03:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:03:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:03:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 09:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 09:03:36 INFO - Using env: {'DISPLAY': ':0', 09:03:36 INFO - 'HOME': '/home/cltbld', 09:03:36 INFO - 'LANG': 'en_US.UTF-8', 09:03:36 INFO - 'LANGUAGE': 'en_US:en', 09:03:36 INFO - 'LOGNAME': 'cltbld', 09:03:36 INFO - 'MAIL': '/var/mail/cltbld', 09:03:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:03:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:36 INFO - 'MOZ_NO_REMOTE': '1', 09:03:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:36 INFO - 'NO_EM_RESTART': '1', 09:03:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:36 INFO - 'PWD': '/builds/slave/test', 09:03:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:03:36 INFO - 'SHELL': '/bin/bash', 09:03:36 INFO - 'SHLVL': '1', 09:03:36 INFO - 'TERM': 'linux', 09:03:36 INFO - 'TMOUT': '86400', 09:03:36 INFO - 'USER': 'cltbld', 09:03:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976', 09:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:36 INFO - '_': '/tools/buildbot/bin/python'} 09:03:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 09:03:36 INFO - mozversion application_buildid: 20161221065215 09:03:36 INFO - mozversion application_changeset: e6ec59a1128a587af3d45b9d529105cee4e1205d 09:03:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:03:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:03:36 INFO - mozversion application_name: Firefox 09:03:36 INFO - mozversion application_remotingname: firefox-dev 09:03:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:03:36 INFO - mozversion application_vendor: Mozilla 09:03:36 INFO - mozversion application_version: 52.0a2 09:03:36 INFO - mozversion platform_buildid: 20161221065215 09:03:36 INFO - mozversion platform_changeset: e6ec59a1128a587af3d45b9d529105cee4e1205d 09:03:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:03:36 INFO - mozversion platform_version: 52.0a2 09:03:36 INFO - using testdate: 1482339816 09:03:36 INFO - actual date: 1482339816 09:03:36 INFO - starting webserver on 'localhost:48416' 09:03:36 INFO - SUITE-START | Running 2 tests 09:03:36 INFO - TEST-START | dromaeo_css 09:03:36 INFO - operating with platform_type : linux_ 09:03:36 INFO - Initialising browser for dromaeo_css test... 09:03:36 INFO - TEST-INFO | started process 30100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgPo0kl/profile http://localhost:48416/getInfo.html) 09:03:40 INFO - PROCESS | 30100 | __metrics Screen width/height:1600/1200 09:03:40 INFO - PROCESS | 30100 | colorDepth:24 09:03:40 INFO - PROCESS | 30100 | Browser inner width/height: 1024/697 09:03:40 INFO - PROCESS | 30100 | __metrics 09:03:41 ERROR - PROCESS | 30100 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:03:42 INFO - TEST-INFO | 30100: exit 0 09:03:42 INFO - Browser initialized. 09:03:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:03:42 INFO - TEST-INFO | started process 30232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgPo0kl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:53 INFO - PROCESS | 30232 | RSS: Main: 152174592 09:03:53 INFO - PROCESS | 30232 | 09:04:43 INFO - PROCESS | 30232 | 1482339883396 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] 09:06:54 INFO - PROCESS | 30232 | Cycle 1(1): loaded http://localhost:48416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48416/tests/dromaeo/cssquery-ext.html) 09:06:56 INFO - PROCESS | 30232 | RSS: Main: 155533312 09:06:56 INFO - PROCESS | 30232 | 09:09:58 INFO - PROCESS | 30232 | Cycle 1(1): loaded http://localhost:48416/tests/dromaeo/cssquery-ext.html (next: http://localhost:48416/tests/dromaeo/cssquery-jquery.html) 09:09:58 INFO - PROCESS | 30232 | RSS: Main: 153624576 09:09:58 INFO - PROCESS | 30232 | 09:13:00 INFO - PROCESS | 30232 | Cycle 1(1): loaded http://localhost:48416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48416/tests/dromaeo/cssquery-mootools.html) 09:13:01 INFO - PROCESS | 30232 | RSS: Main: 153575424 09:13:01 INFO - PROCESS | 30232 | 09:16:03 INFO - PROCESS | 30232 | Cycle 1(1): loaded http://localhost:48416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48416/tests/dromaeo/cssquery-prototype.html) 09:16:03 INFO - PROCESS | 30232 | RSS: Main: 151961600 09:16:03 INFO - PROCESS | 30232 | 09:19:06 INFO - PROCESS | 30232 | Cycle 1(1): loaded http://localhost:48416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48416/tests/dromaeo/cssquery-yui.html) 09:19:06 INFO - PROCESS | 30232 | RSS: Main: 154808320 09:19:06 INFO - PROCESS | 30232 | 09:22:08 INFO - PROCESS | 30232 | Cycle 1(1): loaded http://localhost:48416/tests/dromaeo/cssquery-yui.html (next: http://localhost:48416/tests/dromaeo/cssquery-dojo.html) 09:22:09 INFO - PROCESS | 30232 | RSS: Main: 155566080 09:22:09 INFO - PROCESS | 30232 | 09:22:09 INFO - PROCESS | 30232 | __start_tp_report 09:22:09 INFO - PROCESS | 30232 | _x_x_mozilla_page_load 09:22:09 INFO - PROCESS | 30232 | _x_x_mozilla_page_load_details 09:22:09 INFO - PROCESS | 30232 | |i|pagename|runs| 09:22:09 INFO - PROCESS | 30232 | |0;dojo.html;3310.2386451116245;3328.1180487170905;3332.400167969766;3338.582677165354;3345.732341412687;5702.714864256786;5739.512141467975;5750.942490575093;5759.308882934054;5765.164051212571;5746.7413966371505;5819.62172458791;5825.8252252432385;5843.18195452637;5853.7951171709;5244.370675518933;5253.527182553569;5296.073187192245;5304.893902121975;5331.120365139747;5340;5347.331583552056;5348.679079255257;5354.651947623392;5375.919361209585;5193.714345710984;5198.714070726109;5306.734663266821;5351.117065684158;5353.330833645794;5254.737263136866;5298.311219541454;5302.549283310885;5304.575633949275;5349.786008559692;5151.5621172200035;5211.270422140903;5214.713190774506;5219.373675159005;5248.343957005374;5770.480656740913;5807.361190269067;5828.446297601763;5832.591718579701;5852.67810270435;6112.777056696867;6165.32181460039;6184.721687524072;6215.81352559424;6249.187605611287;6256.655883926383;6312.52656050798;6339.809805705836;6340.968295158541;6354.078658594478;5652.886942261214;5885.646861188342;5889.407461448513;5892.558058145571;5892.882142357129;6180.165677633462;6197.194364732556;6240.594361366497;6243.750249989949;6340.587861788969;6080.574359794772;6099.725512351954;6123.877522449526;6132.63204207749;6135.478484328882;6205.193324867739;6222.253329600387;6224.875502490016;6225.315215326311;6234.0025595905345;6023.186869772525;6024.036154215304;6131.621347939075;6159.599626024384;6169.722362493699;6204.751809927642;6224.284207316216;6235.251769787655;6257.561970662101;6268.592541484789;4731.834385796549;4739.715617062987;4741.454732705714;4747.620190384761;4824.276358546176;4069.1251380953236;4118.876433706993;4194.182134483746;4199.328107502785;4261.637760790368;5964.284285885721;5969.611975221596;5983.1623572699855;5984.431479009487;6030.03519436888;6260.718267677966;6268.122462855204;6282.308946015934;6285.088662143963;6303.495720342362;5842.503387212049;5857.912131318034;5892.970535147297;5974.40255974399;5980.431858973478;5366.356037275474;5368.409474957752;5375.408705042442;5376.7042812644895;5385.138377859524;6453.709583068773;6495.740170393131;6539.444147247537;6553.41019308255;6553.574017688835;6063.909041364472;6157.507399408126;6173.629582225081;6173.84565385869;6318.27339855904;6458.128152699325;6465.579737317059;6475.708593113227;6477.028445733178;6481.870362592627;6153.230846144232;6160.168377269011;6185.41238582334;6186.81439556814;6192.81421557354;6006.969965150146;6121.969390153021;6125.908111378422;6260.029695397221;6286.591371560834;6029.397060293935;6044.637321760709;6121.357257488078;6139.539534535017;6198.659073750807;6132.846678833065;6138.447539721446;6138.570300078952;6140.846478838065;6146.508279337553;6071.908921366095;6080.118382834553;6093.956793010324;6097.146399503984;6138.602983404897;5988.131720900532;6039.335673075871;6077.361877003028;6095.542834287357;6131.325554189125;6014.969925150346;6021.578489505692;6026.15633811258;6029.155918171372;6055.757769689163 09:22:09 INFO - PROCESS | 30232 | |1;ext.html;567.3673853653178;612.5650787940563;637.193949653688;655.5968079631025;666.1939053744968;44295.33556996644;45512.31731524026;45711.77144114283;45740;45797;43497.130057398834;43980.560194398044;44113.77943110288;44117;44150.33774493377;8555.914440855606;8790.780230494225;8798.604062817189;8821;8832.955835220815;8863.512506812123;8944.686935957243;8946.418482798597;8954.776130596754;8968.192862642361;8887.600057997406;8904.109589041109;8920.821583568357;8997.05530919254;9008.729738107868;8781.868271975925;8864.202221800037;8873.822523549557;8916.15296546827;8931.285497160212;8793.824123517557;8829.823403531958;8864.379493435463;8884.777880552972;8892.644294228223;41039.58960410387;41192.794036029925;41206;41261.381079283834;41348.58651413507;3561.857525698995;3692.0585250760882;3700.5374328208973;3908.218356328746;4427.2695005324085;31760;31987;32019;32087.83956080228;32351.838240808644;4439.400680908068;4509.233430316854;4522.253828118356;4524.954750452486;4543.204939135671;357166;359204;359447;359925;361828;59988.40011599915;60171;60472;60508;60524.39475605276;62489.37510624836;62646.68676656587;62896.68551657212;63270.36729632737;63527.364726353066;18345.72481412753;18582.25670973146;18591.07044647762;18611.81388186101;18612.906935465235;14035.71928561423;14154.646133846736;14194.574162775134;14217.146971181763;14251.714965700836;15902.284397201922;16596.58508537272;16659;16723;16771.1614419281;6152.784997400932;6198.318184999646;6262.1546091278005;6272.247330320391;6322.083297921868;1026.2303272545591;1034.6533911139702;1070.3738313086776;1124.3310230412892;1141.2296699727651;32458;32562.67437325644;32726.509102363485;32815.50776738351;33194.170145746546;1140.766142940695;1171.5723760827236;1181.7518321152481;1192.6124009696882;1229.624964385853;16964.74552881708;17155.399561015303;17179;17274.222659980333;17584.38454654081;548981;552696;554475;554648;558122;61513;61785.07322390168;61861.07208391878;62107;62274;1356.0981947005132;1390.7566175919173;1405.9226742529054;1415.7947097670985;1418.8368337641098;31642.525362119126;32693.836530818146;32938.67061329356;33259.334813304085;33775.66224337725;52369;53194.202086967955;53239.733801330745;53394;53406.73296633492;455756;456516;457960;459242;459549;29997.250068748457;30067.248318792204;30275.394492110474;30549.389012220076;30591.847040765544;47933.28100078432;48118;49728;49763.50236497589;50046;41540;41732.58267417287;41796.58203417927;42407;43790;41402;41870.58129418667;42108.789456052524;43207;43903.34144987891;41542.1691566173;42477;43726.78136609297;43802.12395752003;46250.30624540567;36879.63120368762;37024.25951481009;37533.62466375301;37937.43093853539;38210.42684359681;29243.85378073096;29615.851920740257;29851.253718657208;29897.70102298949;30143.397132057675 09:22:09 INFO - PROCESS | 30232 | |2;jquery.html;434.97172683775574;437.7461072577905;441.7410380415814;442.45136031321164;444.99110017799666;18416.81583184168;19130.808691913095;19984.60030799385;19999.100040498175;20147.899260503676;18744.81255187448;19410.902945485253;19563.804361956376;19655.606887862235;19778.901105494453;5220.164773636219;5417.052015897222;5480.91778623321;5495.120780675093;5500.614956953015;5387.595930305223;5444.482774136451;5454.127339625661;5474.698891560983;5835.912461313083;5855.560832937525;5855.648661080328;5887.970560147215;5888.057910734262;5893.58744887858;5633.830985070434;5795.362510123883;5807.651540907559;5857.619254748449;5900.675462849542;5367.087595108841;5382.650127741724;5388.568914486871;5392.541633961118;5395.460453954613;23341;23997;24344.417612855286;24528;24546.631800523006;2425.9393515162087;2445.6453814196843;2453.4234454903085;2457.3610861176044;2917.705735660848;10585.259031867772;11027.889721102767;11193.16051296156;11539.59611413605;11548.711282217928;1897.5351038995534;1994.870333428337;2028.2799606139756;2075.9723936651453;2118.947026324339;92471.53764231203;92911;94801.52599237028;95494;97011;11832.585859494877;12000.399980000964;12112.273263604213;12115;12224.938875305566;17358.39245626397;17362.39231626887;17377.131143442777;17403.390881319094;17445.651086978443;8741.562921853882;8989.235914947303;9166.67916622915;9238.67664631748;9327.393719408217;8856.070112638208;8860.291176705978;8876.600552975131;9058.094190580889;9086.409383390059;4815.109204797123;5048.747562621854;5126.359205099363;5129.820456284012;5272.947270527322;2121.0349291072525;2133.4986278224605;2159.157928407922;2181.149351752818;2201.735791705006;967.2165545907837;999.4602914426274;1079.0361541993652;1089.4443833644898;1115.9051480624075;20245.493862653257;20492.18031278762;20616.278430254868;20818.791812081687;21531.461713457287;1009.2178561614661;1058.5501162006117;1093.2238110941162;1100.0814320042693;1136.755597546515;10924;11324.943375283236;11390.772184556263;11410.600628977945;11453.484593193327;529282;533368;538138;538452;539532;92317;94413.5279323599;104807.4759626197;106154;111328;1061.766411389493;1097.9945100274608;1104.7293413113678;1104.7569534702352;1108.2131686502673;16406.753898691768;16722.498325050266;17005.744913826056;17175.7423638643;17388.652226955644;44495.33257001212;44853.32720009268;45045;45376.999999998676;45862;60414.69792651009;64044;64864.35135648583;65100.674496627216;65779.34220657732;8926.821463570563;9010.774730631525;9156.313276504423;9178.816423671622;9312.674056407994;9644.662436814679;12751.744965100832;13018.804717929428;13033.15284506504;13088.672783180496;11464.426778660867;11605.419729013347;11605.6518304451;11703.356315402734;11734.94132529332;10924.890751092387;10961.890381096087;11284.21010529255;11313.377764222718;11400.771984560428;11538;11565.132615054074;11598.536058557564;11974.760504789681;11979;9138.314626402913;9263.120003599648;9465.905340946503;9475.54929102128;9567.61729530811;8543.743687689379;8865.069167737294;9067.09329067088;10241.692749217535;11650.88349116532 09:22:09 INFO - PROCESS | 30232 | |3;mootools.html;1539.2996186735036;1543.5909483986743;1737.6350966297077;1850.6668799616073;1864.9067546622666;8127.390445716565;8396.538190399526;8793.692220772275;9373.390729602579;9474.526273686322;8729.170728780771;8890.244329232008;9043.63825446983;9217.76955576111;9324.440533567991;2537.0486067724605;2548.9490210195786;2555.4505781257026;2564.833285836424;2569.961450578243;2456.852588844675;2522.1928982725535;2531.0508559290265;2547.885345159463;2556.897724091034;2483.1681386735463;2505.1607711416696;2506.6616006839026;2506.6616006839117;2507.3480894967256;2420.8426452280546;2451.7180524239675;2484.925452236436;2484.981157725324;2486.316263027664;2427.1141033522813;2439.597466418039;2454.6808914841135;2461.815363847719;2468.4322605800585;9252.814943701156;9317.487538185396;9319.90680093197;9345.73832532613;9431.15119639229;5673.461021202979;5755;5796.797112101099;5804.796832110898;5809.88380232393;3720.1257704439436;3776.131489757344;3805.1438426354125;3820.36963900956;3826.7754318618054;1196.2702751321688;1197.2457351868354;1223.7858374784378;1245.9688507787287;1308.6074177746639;12847.421866016051;13092.149010314299;13105.672358191026;13133.27766972816;13133.737325253536;4993.101241776442;5078.111330517145;5157.226416037549;5254.684718916801;5312.389075256395;10966.067884229771;10999.285046471954;11006.679198496231;11042.779144417067;11072.557097716162;5838.8540286492325;5843.094320380348;5853.2976042875125;5879.176915231871;5880.294364676266;4436.82252709888;5168.689878607221;5234.031704134747;5258.0009798138235;5340.732963351817;4278.272693642089;4314.935275970863;4343.478782546114;4379.5839395258035;4380.6057454829215;1413.0673755321643;1416.4617445370693;1424.985750142506;1427.942882284697;1430.8640679135465;989.1740396768635;991.2961797123978;1010.5351538292321;1015.2690063154517;1018.33808024783;6036.607620504653;6117.938820611826;6118.082287656887;6183.938160618426;6186.257649082139;495.30657080087445;497.7337124638374;498.03381440006274;505.1286530734527;1068.1027936533194;3940.133170702441;4123.175364927027;4156.56356082607;4179.310413781753;4250.511191212988;11358.204925655291;11551;11580.76838463226;11606.24559403636;11649.359285239223;11265.380404077854;11353.716157096138;11521.251118677259;11533.653990380302;11534.769304613861;8599.226069653761;8749.343799215085;8865.157810008039;8868.822623547492;8883;5856.180134781219;6001.879962400815;6045.274567051982;6082.817515474543;6096.786612468542;10409.583616655249;10419.06228439444;10543.261971662218;10547.841782373423;10660.946695266784;10481.633142839964;10710.464476776286;10734.570617175226;10773.946130269298;10864.674059778219;7143.249958754256;7391.8152046199275;7539.585322807298;7799.805004874924;7863.685452581833;8935.955320223356;9214.953925230331;9229.215516680888;9239.983601803931;9240.937292211212;7773.961130194313;7840.294373506412;7844.64699088531;8079.959600202196;8090.1909809018625;7843;7898.2891539761695;7960.880586791319;8019.83960320802;8209.179082091743;7049.400800931979;7133.750318738819;7184.030155929092;7185.173705023989;7210.206877243604;5223.373195216598;5226.947730522798;5229.869253268699;5302.814401495929;5352.866178345573;5300.284461597635;5348.598855085962;5368.785248590013;5399.190121481809;5583.994880921473 09:22:09 INFO - PROCESS | 30232 | |4;prototype.html;355.89678993092;360.49530657080084;364.50427418710547;365.7933267703749;369.68761396619846;5726.3128424589;5728.6562806231605;5794.536437085034;5815.767369305228;5820;5500.339959204901;5646.560127167567;5655.604107712462;5676.347220069693;5698.518385219842;4407.515173330947;4418.204723149832;4436.622887054604;4464.374987501752;4484.125595508877;4455.509893911667;4456.064226512436;4468.262736648449;4489.5285994970545;4503.752293623849;4410;4445.8221671133115;4450.688451808374;4461.866144015685;4467.5755803198645;4317.913641727164;4397.626201772853;4423.889402764957;4429.712068715523;4433.733975961421;3932.2304962766584;3933.8033098345254;3938.645521903014;3941.600731740248;3943.3493473576827;5493.148561972901;5514.889702205974;5556.333240011184;5561.165825126223;5564.972175139139;5018.222175562793;5072.391313042422;5073.543381095719;5097.8215762448135;5099.5410413063;5876.147958546029;5900.616459930091;5914.2015827863115;5919.112133180014;5935.258092738408;4265.829366825324;4363.847265345697;4370.169667763115;4373.1472362888935;4381.9342709859375;5934.258217722785;6119.908201376938;6163.1063495793305;6178.7219575119225;6188.350223226586;4350.086481838786;4364.781760911942;4372.453443319585;4386.758728269912;4401.8555175654565;4354.325079612665;4398.69209155356;4402.4056752338665;4421.358902959118;4430.446194225722;4913;5018.673786203885;5030.37120359955;5053.7473126344275;5095.490450954949;5930.9406905931255;5935.584509084322;5936.881262374728;5957.374475680078;5968.731407086605;1464.4727897956727;1491.4407097338499;1496.565995861188;1499.5576304989836;1505.9397624095132;977.4672803322206;1023.5445226874118;1025.4565080507343;1045.9790804183874;1050.6900464363032;5583.29709438617;5589.720513974285;5612.316305108451;5643.35101463337;5655.462731040545;5905.43898329658;5919.756851061239;5919.845630102175;5935.584509084322;5966.820995370059;5316.255724198615;5479.205515200274;5524.392316845144;5553.4724201201625;5673.5461163107675;3144.5440411140257;3146.8269245191736;3151.353972435645;3153.8896138635496;3179.300553878143;5905.76376944926;6093.969530152321;6101.389861013952;6135.9079613805825;6148.077788331786;5930.495907847795;5965;5972;5978.491828194652;6064.211652485237;6072.423119803611;6075.453209211104;6082.726277317532;6116.938830611726;6159.414855588801;5791.422816846463;5809.883802323845;5872.530197584098;5902.852428689317;5958.582899197015;5690.971545142248;5791.652500849962;5814.622049566765;5828.59199856006;5831.650100993954;6087.447700836258;6273.560850740404;6291.96854015727;6335.1447554579545;6339.683015849281;4415.116976604756;4465.330200469825;4475.731456112644;4475.77744024302;4491.73049617024;6050.273967123973;6159.414855588712;6185.6391593849285;6246.187995560548;6270.773875274212;5959.404059594006;5965.85229317454;5973.970130149321;5980.730867110903;5993.790217342372;5872;5927.347991720821;5974.372690867396;5978.730957106854;6009.90985135232;5876.676782776988;5903.605426879647;5926.081352477519;5928.733207005609;5933.486960824962;6020.976434006142;6040.2147720797775;6043.909341359971;6052.485538729257;6068.21113255274;5712.428757124254;5835.103591332919;5856.736446859816;5922.318933322723;5934.495567876779 09:22:09 INFO - PROCESS | 30232 | |5;yui.html;783.3028604541962;792.5324058805304;813.4265342933232;840.3571267979996;877.3726785348476;15353.232338383092;16345.836541634595;16423.83576164238;16457.83542164578;16464.91767541162;13727.65680857979;13880.722385552283;13929.512467063654;14010.299485025733;14118;836.7280633794026;839.1566475691922;843.7173546861809;847.6736456464243;849.049065047148;846.3313981954249;849.8682704180831;850.5662112322728;851.2849206666399;852.7186028610574;889.6263569300909;892.6072528087653;893.2987604730288;894.0880302091863;895.212213252337;888.6711916590903;888.9955550222207;889.5552223888056;893.3880291999968;894.874717539545;646.385933363302;648.9415952564292;654.9443297319733;656.2059907511916;658.1246941567704;13384.732305353935;13391.397387117602;13406.597802065953;13419.731605367935;13433.261170635611;12527.123101382907;12715.936420317932;12767.489300428064;12811.615651530468;12835;10758;10779.137668986463;10818;10836.783264334668;10943.671689849318;3762.4168253920684;3803.182315802088;3812.752171108869;3847.8460861565504;3931.82306796192;65893;66467;67119.32880671228;68786.9999999995;70549;9268;9856.802863942825;9891.505424728735;9923.305368624127;9963.302568820258;18447.354342597944;18470.538236544195;18654.253829846653;18851.528711782314;19088.61822763537;7515.6242187891485;7912.0901096374655;7970.6413211405625;8035.919640803634;8203.630836612367;4325.394444777734;4542.091581683677;4582.221022426195;4675.18184317743;4749.810007599726;3553.1117220694828;3698.14942563212;3698.68561172298;3711.2763011213096;3720.2931443025736;640.4108220437209;641.6246495799916;643.3116565275204;649.3117295666608;650.0931200974613;776.3556248313886;782.8708263136518;798.6885114805231;812.5937031484258;833.8582440984926;8832.690855820145;9393.57728902201;9477.383970041925;9569.058682324478;9683.854742178873;697.7545082028555;747.3311386309332;761.2235519769804;767.1522967121363;768.3507436216388;4300.548442413564;4406.294992801137;4446.488653804854;4450.777461126931;4483.21543729846;92505.53747231221;93334.53332733293;93549.53225233966;95052;97230;78363.21636783674;79100;81467;82110;82186.58906705429;69939.30060699327;72576;75253;75580.24419755842;75924.62037689776;8694.39139260271;8752.431091979;8847.46915185091;8849.247813935888;9061.365704400629;48777.75611121922;49071.50928490669;49609.50390496193;50660.24009639932;51480.48519514907;56946;59853.700731497804;63190;67506.66246668735;70872.29127708657;12900.548480803127;12900.93549532284;13018;13139;13173.60479185626;13983.790243146157;14097.929510352382;14254.643633909236;14613;14698.63253418673;13246.933765331112;13311.600651980456;13453.46186152582;13631.454741810614;13737.24445155526;13325.466981320638;13726.382312795748;13922.373493193034;14004.579862604138;14354.425822966965;12707.237565746085;13155.868441315464;13381.264030478027;13480.123791953492;13684.31578421055;10537.315074520131;10584;10685.198610104118;10856.45717714127;10881.129509639368;10464.790704185722;10828.242023058625;11036.061934735637;11074.169437292074;11091.611793587186 09:22:09 INFO - PROCESS | 30232 | __end_tp_report 09:22:09 INFO - PROCESS | 30232 | __start_cc_report 09:22:09 INFO - PROCESS | 30232 | _x_x_mozilla_cycle_collect,315 09:22:09 INFO - PROCESS | 30232 | __end_cc_report 09:22:09 INFO - PROCESS | 30232 | __startTimestamp1482340929119__endTimestamp 09:22:09 INFO - PROCESS | 30232 | 09:22:09 INFO - PROCESS | 30232 | ------- Summary: start ------- 09:22:09 INFO - PROCESS | 30232 | Number of tests: 6 09:22:09 INFO - PROCESS | 30232 | 09:22:09 INFO - PROCESS | 30232 | [#0] dojo.html Cycles:165 Average:5782.62 Median:6029.40 stddev:668.86 (11.1%) stddev-sans-first:642.17 09:22:09 INFO - PROCESS | 30232 | Values: 3310.2 3328.1 3332.4 3338.6 3345.7 5702.7 5739.5 5750.9 5759.3 5765.2 5746.7 5819.6 5825.8 5843.2 5853.8 5244.4 5253.5 5296.1 5304.9 5331.1 5340.0 5347.3 5348.7 5354.7 5375.9 5193.7 5198.7 5306.7 5351.1 5353.3 5254.7 5298.3 5302.5 5304.6 5349.8 5151.6 5211.3 5214.7 5219.4 5248.3 5770.5 5807.4 5828.4 5832.6 5852.7 6112.8 6165.3 6184.7 6215.8 6249.2 6256.7 6312.5 6339.8 6341.0 6354.1 5652.9 5885.6 5889.4 5892.6 5892.9 6180.2 6197.2 6240.6 6243.8 6340.6 6080.6 6099.7 6123.9 6132.6 6135.5 6205.2 6222.3 6224.9 6225.3 6234.0 6023.2 6024.0 6131.6 6159.6 6169.7 6204.8 6224.3 6235.3 6257.6 6268.6 4731.8 4739.7 4741.5 4747.6 4824.3 4069.1 4118.9 4194.2 4199.3 4261.6 5964.3 5969.6 5983.2 5984.4 6030.0 6260.7 6268.1 6282.3 6285.1 6303.5 5842.5 5857.9 5893.0 5974.4 5980.4 5366.4 5368.4 5375.4 5376.7 5385.1 6453.7 6495.7 6539.4 6553.4 6553.6 6063.9 6157.5 6173.6 6173.8 6318.3 6458.1 6465.6 6475.7 6477.0 6481.9 6153.2 6160.2 6185.4 6186.8 6192.8 6007.0 6122.0 6125.9 6260.0 6286.6 6029.4 6044.6 6121.4 6139.5 6198.7 6132.8 6138.4 6138.6 6140.8 6146.5 6071.9 6080.1 6094.0 6097.1 6138.6 5988.1 6039.3 6077.4 6095.5 6131.3 6015.0 6021.6 6026.2 6029.2 6055.8 09:22:09 INFO - PROCESS | 30232 | 09:22:09 INFO - PROCESS | 30232 | [#1] ext.html Cycles:180 Average:62289.25 Median:43758.39 stddev:123007.77 (281.1%) stddev-sans-first:123265.54 09:22:09 INFO - PROCESS | 30232 | Values: 567.4 612.6 637.2 655.6 666.2 44295.3 45512.3 45711.8 45740.0 45797.0 43497.1 43980.6 44113.8 44117.0 44150.3 8555.9 8790.8 8798.6 8821.0 8833.0 8863.5 8944.7 8946.4 8954.8 8968.2 8887.6 8904.1 8920.8 8997.1 9008.7 8781.9 8864.2 8873.8 8916.2 8931.3 8793.8 8829.8 8864.4 8884.8 8892.6 41039.6 41192.8 41206.0 41261.4 41348.6 3561.9 3692.1 3700.5 3908.2 4427.3 31760.0 31987.0 32019.0 32087.8 32351.8 4439.4 4509.2 4522.3 4525.0 4543.2 357166.0 359204.0 359447.0 359925.0 361828.0 59988.4 60171.0 60472.0 60508.0 60524.4 62489.4 62646.7 62896.7 63270.4 63527.4 18345.7 18582.3 18591.1 18611.8 18612.9 14035.7 14154.6 14194.6 14217.1 14251.7 15902.3 16596.6 16659.0 16723.0 16771.2 6152.8 6198.3 6262.2 6272.2 6322.1 1026.2 1034.7 1070.4 1124.3 1141.2 32458.0 32562.7 32726.5 32815.5 33194.2 1140.8 1171.6 1181.8 1192.6 1229.6 16964.7 17155.4 17179.0 17274.2 17584.4 548981.0 552696.0 554475.0 554648.0 558122.0 61513.0 61785.1 61861.1 62107.0 62274.0 1356.1 1390.8 1405.9 1415.8 1418.8 31642.5 32693.8 32938.7 33259.3 33775.7 52369.0 53194.2 53239.7 53394.0 53406.7 455756.0 456516.0 457960.0 459242.0 459549.0 29997.3 30067.2 30275.4 30549.4 30591.8 47933.3 48118.0 49728.0 49763.5 50046.0 41540.0 41732.6 41796.6 42407.0 43790.0 41402.0 41870.6 42108.8 43207.0 43903.3 41542.2 42477.0 43726.8 43802.1 46250.3 36879.6 37024.3 37533.6 37937.4 38210.4 29243.9 29615.9 29851.3 29897.7 30143.4 09:22:09 INFO - PROCESS | 30232 | 09:22:09 INFO - PROCESS | 30232 | [#2] jquery.html Cycles:180 Average:31403.03 Median:13395.03 stddev:88593.55 (661.4%) stddev-sans-first:88811.56 09:22:09 INFO - PROCESS | 30232 | Values: 435.0 437.7 441.7 442.5 445.0 18416.8 19130.8 19984.6 19999.1 20147.9 18744.8 19410.9 19563.8 19655.6 19778.9 5220.2 5417.1 5480.9 5495.1 5500.6 5387.6 5444.5 5454.1 5474.7 5835.9 5855.6 5855.6 5888.0 5888.1 5893.6 5633.8 5795.4 5807.7 5857.6 5900.7 5367.1 5382.7 5388.6 5392.5 5395.5 23341.0 23997.0 24344.4 24528.0 24546.6 2425.9 2445.6 2453.4 2457.4 2917.7 10585.3 11027.9 11193.2 11539.6 11548.7 1897.5 1994.9 2028.3 2076.0 2118.9 92471.5 92911.0 94801.5 95494.0 97011.0 11832.6 12000.4 12112.3 12115.0 12224.9 17358.4 17362.4 17377.1 17403.4 17445.7 8741.6 8989.2 9166.7 9238.7 9327.4 8856.1 8860.3 8876.6 9058.1 9086.4 4815.1 5048.7 5126.4 5129.8 5272.9 2121.0 2133.5 2159.2 2181.1 2201.7 967.2 999.5 1079.0 1089.4 1115.9 20245.5 20492.2 20616.3 20818.8 21531.5 1009.2 1058.6 1093.2 1100.1 1136.8 10924.0 11324.9 11390.8 11410.6 11453.5 529282.0 533368.0 538138.0 538452.0 539532.0 92317.0 94413.5 104807.5 106154.0 111328.0 1061.8 1098.0 1104.7 1104.8 1108.2 16406.8 16722.5 17005.7 17175.7 17388.7 44495.3 44853.3 45045.0 45377.0 45862.0 60414.7 64044.0 64864.4 65100.7 65779.3 8926.8 9010.8 9156.3 9178.8 9312.7 9644.7 12751.7 13018.8 13033.2 13088.7 11464.4 11605.4 11605.7 11703.4 11734.9 10924.9 10961.9 11284.2 11313.4 11400.8 11538.0 11565.1 11598.5 11974.8 11979.0 9138.3 9263.1 9465.9 9475.5 9567.6 8543.7 8865.1 9067.1 10241.7 11650.9 09:22:09 INFO - PROCESS | 30232 | 09:22:09 INFO - PROCESS | 30232 | [#3] mootools.html Cycles:180 Average:6097.46 Median:496.52 stddev:3454.12 (695.7%) stddev-sans-first:3446.82 09:22:09 INFO - PROCESS | 30232 | Values: 1539.3 1543.6 1737.6 1850.7 1864.9 8127.4 8396.5 8793.7 9373.4 9474.5 8729.2 8890.2 9043.6 9217.8 9324.4 2537.0 2548.9 2555.5 2564.8 2570.0 2456.9 2522.2 2531.1 2547.9 2556.9 2483.2 2505.2 2506.7 2506.7 2507.3 2420.8 2451.7 2484.9 2485.0 2486.3 2427.1 2439.6 2454.7 2461.8 2468.4 9252.8 9317.5 9319.9 9345.7 9431.2 5673.5 5755.0 5796.8 5804.8 5809.9 3720.1 3776.1 3805.1 3820.4 3826.8 1196.3 1197.2 1223.8 1246.0 1308.6 12847.4 13092.1 13105.7 13133.3 13133.7 4993.1 5078.1 5157.2 5254.7 5312.4 10966.1 10999.3 11006.7 11042.8 11072.6 5838.9 5843.1 5853.3 5879.2 5880.3 4436.8 5168.7 5234.0 5258.0 5340.7 4278.3 4314.9 4343.5 4379.6 4380.6 1413.1 1416.5 1425.0 1427.9 1430.9 989.2 991.3 1010.5 1015.3 1018.3 6036.6 6117.9 6118.1 6183.9 6186.3 495.3 497.7 498.0 505.1 1068.1 3940.1 4123.2 4156.6 4179.3 4250.5 11358.2 11551.0 11580.8 11606.2 11649.4 11265.4 11353.7 11521.3 11533.7 11534.8 8599.2 8749.3 8865.2 8868.8 8883.0 5856.2 6001.9 6045.3 6082.8 6096.8 10409.6 10419.1 10543.3 10547.8 10660.9 10481.6 10710.5 10734.6 10773.9 10864.7 7143.2 7391.8 7539.6 7799.8 7863.7 8936.0 9215.0 9229.2 9240.0 9240.9 7774.0 7840.3 7844.6 8080.0 8090.2 7843.0 7898.3 7960.9 8019.8 8209.2 7049.4 7133.8 7184.0 7185.2 7210.2 5223.4 5226.9 5229.9 5302.8 5352.9 5300.3 5348.6 5368.8 5399.2 5584.0 09:22:09 INFO - PROCESS | 30232 | 09:22:09 INFO - PROCESS | 30232 | [#4] prototype.html Cycles:180 Average:4983.54 Median:5664.58 stddev:1446.72 (25.5%) stddev-sans-first:1408.46 09:22:09 INFO - PROCESS | 30232 | Values: 355.9 360.5 364.5 365.8 369.7 5726.3 5728.7 5794.5 5815.8 5820.0 5500.3 5646.6 5655.6 5676.3 5698.5 4407.5 4418.2 4436.6 4464.4 4484.1 4455.5 4456.1 4468.3 4489.5 4503.8 4410.0 4445.8 4450.7 4461.9 4467.6 4317.9 4397.6 4423.9 4429.7 4433.7 3932.2 3933.8 3938.6 3941.6 3943.3 5493.1 5514.9 5556.3 5561.2 5565.0 5018.2 5072.4 5073.5 5097.8 5099.5 5876.1 5900.6 5914.2 5919.1 5935.3 4265.8 4363.8 4370.2 4373.1 4381.9 5934.3 6119.9 6163.1 6178.7 6188.4 4350.1 4364.8 4372.5 4386.8 4401.9 4354.3 4398.7 4402.4 4421.4 4430.4 4913.0 5018.7 5030.4 5053.7 5095.5 5930.9 5935.6 5936.9 5957.4 5968.7 1464.5 1491.4 1496.6 1499.6 1505.9 977.5 1023.5 1025.5 1046.0 1050.7 5583.3 5589.7 5612.3 5643.4 5655.5 5905.4 5919.8 5919.8 5935.6 5966.8 5316.3 5479.2 5524.4 5553.5 5673.5 3144.5 3146.8 3151.4 3153.9 3179.3 5905.8 6094.0 6101.4 6135.9 6148.1 5930.5 5965.0 5972.0 5978.5 6064.2 6072.4 6075.5 6082.7 6116.9 6159.4 5791.4 5809.9 5872.5 5902.9 5958.6 5691.0 5791.7 5814.6 5828.6 5831.7 6087.4 6273.6 6292.0 6335.1 6339.7 4415.1 4465.3 4475.7 4475.8 4491.7 6050.3 6159.4 6185.6 6246.2 6270.8 5959.4 5965.9 5974.0 5980.7 5993.8 5872.0 5927.3 5974.4 5978.7 6009.9 5876.7 5903.6 5926.1 5928.7 5933.5 6021.0 6040.2 6043.9 6052.5 6068.2 5712.4 5835.1 5856.7 5922.3 5934.5 09:22:09 INFO - PROCESS | 30232 | 09:22:09 INFO - PROCESS | 30232 | [#5] yui.html Cycles:180 Average:18477.13 Median:58399.85 stddev:25108.30 (43.0%) stddev-sans-first:25143.58 09:22:09 INFO - PROCESS | 30232 | Values: 783.3 792.5 813.4 840.4 877.4 15353.2 16345.8 16423.8 16457.8 16464.9 13727.7 13880.7 13929.5 14010.3 14118.0 836.7 839.2 843.7 847.7 849.0 846.3 849.9 850.6 851.3 852.7 889.6 892.6 893.3 894.1 895.2 888.7 889.0 889.6 893.4 894.9 646.4 648.9 654.9 656.2 658.1 13384.7 13391.4 13406.6 13419.7 13433.3 12527.1 12715.9 12767.5 12811.6 12835.0 10758.0 10779.1 10818.0 10836.8 10943.7 3762.4 3803.2 3812.8 3847.8 3931.8 65893.0 66467.0 67119.3 68787.0 70549.0 9268.0 9856.8 9891.5 9923.3 9963.3 18447.4 18470.5 18654.3 18851.5 19088.6 7515.6 7912.1 7970.6 8035.9 8203.6 4325.4 4542.1 4582.2 4675.2 4749.8 3553.1 3698.1 3698.7 3711.3 3720.3 640.4 641.6 643.3 649.3 650.1 776.4 782.9 798.7 812.6 833.9 8832.7 9393.6 9477.4 9569.1 9683.9 697.8 747.3 761.2 767.2 768.4 4300.5 4406.3 4446.5 4450.8 4483.2 92505.5 93334.5 93549.5 95052.0 97230.0 78363.2 79100.0 81467.0 82110.0 82186.6 69939.3 72576.0 75253.0 75580.2 75924.6 8694.4 8752.4 8847.5 8849.2 9061.4 48777.8 49071.5 49609.5 50660.2 51480.5 56946.0 59853.7 63190.0 67506.7 70872.3 12900.5 12900.9 13018.0 13139.0 13173.6 13983.8 14097.9 14254.6 14613.0 14698.6 13246.9 13311.6 13453.5 13631.5 13737.2 13325.5 13726.4 13922.4 14004.6 14354.4 12707.2 13155.9 13381.3 13480.1 13684.3 10537.3 10584.0 10685.2 10856.5 10881.1 10464.8 10828.2 11036.1 11074.2 11091.6 09:22:09 INFO - PROCESS | 30232 | -------- Summary: end -------- 09:22:09 INFO - PROCESS | 30232 | 09:22:09 INFO - TEST-INFO | 30232: exit 0 09:22:09 INFO - TEST-OK | dromaeo_css | took 1113625ms 09:22:09 INFO - TEST-START | kraken 09:22:09 INFO - operating with platform_type : linux_ 09:22:09 INFO - Initialising browser for kraken test... 09:22:09 INFO - TEST-INFO | started process 30611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyFty6f/profile http://localhost:48416/getInfo.html) 09:22:14 INFO - PROCESS | 30611 | __metrics Screen width/height:1600/1200 09:22:14 INFO - PROCESS | 30611 | colorDepth:24 09:22:14 INFO - PROCESS | 30611 | Browser inner width/height: 1024/697 09:22:14 INFO - PROCESS | 30611 | __metrics 09:22:14 ERROR - PROCESS | 30611 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:22:15 INFO - TEST-INFO | 30611: exit 0 09:22:15 INFO - Browser initialized. 09:22:15 INFO - Running cycle 1/1 for kraken test... 09:22:15 INFO - TEST-INFO | started process 30747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyFty6f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:27 INFO - PROCESS | 30747 | RSS: Main: 151695360 09:22:27 INFO - PROCESS | 30747 | 09:22:30 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48416/tests/kraken/driver.html?testName=audio-beat-detection) 09:22:31 INFO - PROCESS | 30747 | RSS: Main: 157118464 09:22:31 INFO - PROCESS | 30747 | 09:22:33 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48416/tests/kraken/driver.html?testName=audio-dft) 09:22:34 INFO - PROCESS | 30747 | RSS: Main: 155000832 09:22:34 INFO - PROCESS | 30747 | 09:22:37 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48416/tests/kraken/driver.html?testName=audio-fft) 09:22:37 INFO - PROCESS | 30747 | RSS: Main: 155021312 09:22:37 INFO - PROCESS | 30747 | 09:22:39 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48416/tests/kraken/driver.html?testName=audio-oscillator) 09:22:40 INFO - PROCESS | 30747 | RSS: Main: 155185152 09:22:40 INFO - PROCESS | 30747 | 09:22:42 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:22:43 INFO - PROCESS | 30747 | RSS: Main: 155131904 09:22:43 INFO - PROCESS | 30747 | 09:22:46 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48416/tests/kraken/driver.html?testName=imaging-darkroom) 09:22:46 INFO - PROCESS | 30747 | RSS: Main: 158281728 09:22:46 INFO - PROCESS | 30747 | 09:22:50 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48416/tests/kraken/driver.html?testName=imaging-desaturate) 09:22:50 INFO - PROCESS | 30747 | RSS: Main: 158543872 09:22:50 INFO - PROCESS | 30747 | 09:22:53 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48416/tests/kraken/driver.html?testName=json-parse-financial) 09:22:54 INFO - PROCESS | 30747 | RSS: Main: 158126080 09:22:54 INFO - PROCESS | 30747 | 09:22:55 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:22:56 INFO - PROCESS | 30747 | RSS: Main: 156676096 09:22:56 INFO - PROCESS | 30747 | 09:22:58 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48416/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:22:58 INFO - PROCESS | 30747 | RSS: Main: 157024256 09:22:58 INFO - PROCESS | 30747 | 09:23:00 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:23:01 INFO - PROCESS | 30747 | RSS: Main: 157204480 09:23:01 INFO - PROCESS | 30747 | 09:23:03 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:23:04 INFO - PROCESS | 30747 | RSS: Main: 157708288 09:23:04 INFO - PROCESS | 30747 | 09:23:07 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:23:07 INFO - PROCESS | 30747 | RSS: Main: 158072832 09:23:07 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | Cycle 1(1): loaded http://localhost:48416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48416/tests/kraken/driver.html?testName=ai-astar) 09:23:09 INFO - PROCESS | 30747 | RSS: Main: 159440896 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | __start_tp_report 09:23:09 INFO - PROCESS | 30747 | _x_x_mozilla_page_load 09:23:09 INFO - PROCESS | 30747 | _x_x_mozilla_page_load_details 09:23:09 INFO - PROCESS | 30747 | |i|pagename|runs| 09:23:09 INFO - PROCESS | 30747 | |0;ai-astar;102;112;113;113;112;111;112;111;112;111 09:23:09 INFO - PROCESS | 30747 | |1;audio-beat-detection;147;123;120;174;120;119;118;120;142;120 09:23:09 INFO - PROCESS | 30747 | |2;audio-dft;162;164;163;164;160;162;161;163;162;163 09:23:09 INFO - PROCESS | 30747 | |3;audio-fft;76;76;74;119;77;76;76;76;100;75 09:23:09 INFO - PROCESS | 30747 | |4;audio-oscillator;82;81;113;81;82;81;109;81;82;117 09:23:09 INFO - PROCESS | 30747 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;117;118;120 09:23:09 INFO - PROCESS | 30747 | |6;imaging-darkroom;149;148;147;147;147;148;147;147;147;149 09:23:09 INFO - PROCESS | 30747 | |7;imaging-desaturate;85;85;85;86;85;84;85;86;86;85 09:23:09 INFO - PROCESS | 30747 | |8;json-parse-financial;50;55;56;52;51;51;51;51;51;51 09:23:09 INFO - PROCESS | 30747 | |9;json-stringify-tinderbox;62;61;61;61;61;62;61;61;60;64 09:23:09 INFO - PROCESS | 30747 | |10;stanford-crypto-aes;76;75;84;80;76;76;75;76;76;74 09:23:09 INFO - PROCESS | 30747 | |11;stanford-crypto-ccm;127;122;126;122;126;139;135;122;176;124 09:23:09 INFO - PROCESS | 30747 | |12;stanford-crypto-pbkdf2;156;157;160;158;158;159;157;155;156;155 09:23:09 INFO - PROCESS | 30747 | |13;stanford-crypto-sha256-iterative;64;62;69;69;63;63;65;61;66;65 09:23:09 INFO - PROCESS | 30747 | __end_tp_report 09:23:09 INFO - PROCESS | 30747 | __start_cc_report 09:23:09 INFO - PROCESS | 30747 | _x_x_mozilla_cycle_collect,790 09:23:09 INFO - PROCESS | 30747 | __end_cc_report 09:23:09 INFO - PROCESS | 30747 | __startTimestamp1482340989856__endTimestamp 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | ------- Summary: start ------- 09:23:09 INFO - PROCESS | 30747 | Number of tests: 14 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.21 (2.9%) stddev-sans-first:0.78 09:23:09 INFO - PROCESS | 30747 | Values: 102.0 112.0 113.0 113.0 112.0 111.0 112.0 111.0 112.0 111.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:121.50 stddev:18.51 (15.2%) stddev-sans-first:18.62 09:23:09 INFO - PROCESS | 30747 | Values: 147.0 123.0 120.0 174.0 120.0 119.0 118.0 120.0 142.0 120.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 09:23:09 INFO - PROCESS | 30747 | Values: 162.0 164.0 163.0 164.0 160.0 162.0 161.0 163.0 162.0 163.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:14.94 (19.7%) stddev-sans-first:15.66 09:23:09 INFO - PROCESS | 30747 | Values: 76.0 76.0 74.0 119.0 77.0 76.0 76.0 76.0 100.0 75.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:81.00 stddev:15.37 (19.0%) stddev-sans-first:15.96 09:23:09 INFO - PROCESS | 30747 | Values: 82.0 81.0 113.0 81.0 82.0 81.0 109.0 81.0 82.0 117.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.00 09:23:09 INFO - PROCESS | 30747 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 120.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 09:23:09 INFO - PROCESS | 30747 | Values: 149.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 149.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:23:09 INFO - PROCESS | 30747 | Values: 85.0 85.0 85.0 86.0 85.0 84.0 85.0 86.0 86.0 85.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:51.00 stddev:1.97 (3.9%) stddev-sans-first:1.96 09:23:09 INFO - PROCESS | 30747 | Values: 50.0 55.0 56.0 52.0 51.0 51.0 51.0 51.0 51.0 51.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:1.07 (1.8%) stddev-sans-first:1.12 09:23:09 INFO - PROCESS | 30747 | Values: 62.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 60.0 64.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:2.97 (3.9%) stddev-sans-first:3.14 09:23:09 INFO - PROCESS | 30747 | Values: 76.0 75.0 84.0 80.0 76.0 76.0 75.0 76.0 76.0 74.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:126.50 stddev:16.52 (13.1%) stddev-sans-first:17.42 09:23:09 INFO - PROCESS | 30747 | Values: 127.0 122.0 126.0 122.0 126.0 139.0 135.0 122.0 176.0 124.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:157.50 stddev:1.66 (1.1%) stddev-sans-first:1.72 09:23:09 INFO - PROCESS | 30747 | Values: 156.0 157.0 160.0 158.0 158.0 159.0 157.0 155.0 156.0 155.0 09:23:09 INFO - PROCESS | 30747 | 09:23:09 INFO - PROCESS | 30747 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:2.71 (4.2%) stddev-sans-first:2.86 09:23:09 INFO - PROCESS | 30747 | Values: 64.0 62.0 69.0 69.0 63.0 63.0 65.0 61.0 66.0 65.0 09:23:09 INFO - PROCESS | 30747 | -------- Summary: end -------- 09:23:09 INFO - PROCESS | 30747 | 09:23:10 INFO - TEST-INFO | 30747: exit 0 09:23:10 INFO - TEST-OK | kraken | took 60911ms 09:23:10 INFO - SUITE-END | took 1174s 09:23:11 INFO - Completed test suite (00:19:34) 09:23:11 INFO - javascript benchmark 09:23:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7532.549151450463, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.2386451116245, 3328.1180487170905, 3332.400167969766, 3338.582677165354, 3345.732341412687, 5702.714864256786, 5739.512141467975, 5750.942490575093, 5759.308882934054, 5765.164051212571, 5746.7413966371505, 5819.62172458791, 5825.8252252432385, 5843.18195452637, 5853.7951171709, 5244.370675518933, 5253.527182553569, 5296.073187192245, 5304.893902121975, 5331.120365139747, 5340.0, 5347.331583552056, 5348.679079255257, 5354.651947623392, 5375.919361209585, 5193.714345710984, 5198.714070726109, 5306.734663266821, 5351.117065684158, 5353.330833645794, 5254.737263136866, 5298.311219541454, 5302.549283310885, 5304.575633949275, 5349.786008559692, 5151.5621172200035, 5211.270422140903, 5214.713190774506, 5219.373675159005, 5248.343957005374, 5770.480656740913, 5807.361190269067, 5828.446297601763, 5832.591718579701, 5852.67810270435, 6112.777056696867, 6165.32181460039, 6184.721687524072, 6215.81352559424, 6249.187605611287, 6256.655883926383, 6312.52656050798, 6339.809805705836, 6340.968295158541, 6354.078658594478, 5652.886942261214, 5885.646861188342, 5889.407461448513, 5892.558058145571, 5892.882142357129, 6180.165677633462, 6197.194364732556, 6240.594361366497, 6243.750249989949, 6340.587861788969, 6080.574359794772, 6099.725512351954, 6123.877522449526, 6132.63204207749, 6135.478484328882, 6205.193324867739, 6222.253329600387, 6224.875502490016, 6225.315215326311, 6234.0025595905345, 6023.186869772525, 6024.036154215304, 6131.621347939075, 6159.599626024384, 6169.722362493699, 6204.751809927642, 6224.284207316216, 6235.251769787655, 6257.561970662101, 6268.592541484789, 4731.834385796549, 4739.715617062987, 4741.454732705714, 4747.620190384761, 4824.276358546176, 4069.1251380953236, 4118.876433706993, 4194.182134483746, 4199.328107502785, 4261.637760790368, 5964.284285885721, 5969.611975221596, 5983.1623572699855, 5984.431479009487, 6030.03519436888, 6260.718267677966, 6268.122462855204, 6282.308946015934, 6285.088662143963, 6303.495720342362, 5842.503387212049, 5857.912131318034, 5892.970535147297, 5974.40255974399, 5980.431858973478, 5366.356037275474, 5368.409474957752, 5375.408705042442, 5376.7042812644895, 5385.138377859524, 6453.709583068773, 6495.740170393131, 6539.444147247537, 6553.41019308255, 6553.574017688835, 6063.909041364472, 6157.507399408126, 6173.629582225081, 6173.84565385869, 6318.27339855904, 6458.128152699325, 6465.579737317059, 6475.708593113227, 6477.028445733178, 6481.870362592627, 6153.230846144232, 6160.168377269011, 6185.41238582334, 6186.81439556814, 6192.81421557354, 6006.969965150146, 6121.969390153021, 6125.908111378422, 6260.029695397221, 6286.591371560834, 6029.397060293935, 6044.637321760709, 6121.357257488078, 6139.539534535017, 6198.659073750807, 6132.846678833065, 6138.447539721446, 6138.570300078952, 6140.846478838065, 6146.508279337553, 6071.908921366095, 6080.118382834553, 6093.956793010324, 6097.146399503984, 6138.602983404897, 5988.131720900532, 6039.335673075871, 6077.361877003028, 6095.542834287357, 6131.325554189125, 6014.969925150346, 6021.578489505692, 6026.15633811258, 6029.155918171372, 6055.757769689163], "value": 5736.207067715966, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3673853653178, 612.5650787940563, 637.193949653688, 655.5968079631025, 666.1939053744968, 44295.33556996644, 45512.31731524026, 45711.77144114283, 45740.0, 45797.0, 43497.130057398834, 43980.560194398044, 44113.77943110288, 44117.0, 44150.33774493377, 8555.914440855606, 8790.780230494225, 8798.604062817189, 8821.0, 8832.955835220815, 8863.512506812123, 8944.686935957243, 8946.418482798597, 8954.776130596754, 8968.192862642361, 8887.600057997406, 8904.109589041109, 8920.821583568357, 8997.05530919254, 9008.729738107868, 8781.868271975925, 8864.202221800037, 8873.822523549557, 8916.15296546827, 8931.285497160212, 8793.824123517557, 8829.823403531958, 8864.379493435463, 8884.777880552972, 8892.644294228223, 41039.58960410387, 41192.794036029925, 41206.0, 41261.381079283834, 41348.58651413507, 3561.857525698995, 3692.0585250760882, 3700.5374328208973, 3908.218356328746, 4427.2695005324085, 31760.0, 31987.0, 32019.0, 32087.83956080228, 32351.838240808644, 4439.400680908068, 4509.233430316854, 4522.253828118356, 4524.954750452486, 4543.204939135671, 357166.0, 359204.0, 359447.0, 359925.0, 361828.0, 59988.40011599915, 60171.0, 60472.0, 60508.0, 60524.39475605276, 62489.37510624836, 62646.68676656587, 62896.68551657212, 63270.36729632737, 63527.364726353066, 18345.72481412753, 18582.25670973146, 18591.07044647762, 18611.81388186101, 18612.906935465235, 14035.71928561423, 14154.646133846736, 14194.574162775134, 14217.146971181763, 14251.714965700836, 15902.284397201922, 16596.58508537272, 16659.0, 16723.0, 16771.1614419281, 6152.784997400932, 6198.318184999646, 6262.1546091278005, 6272.247330320391, 6322.083297921868, 1026.2303272545591, 1034.6533911139702, 1070.3738313086776, 1124.3310230412892, 1141.2296699727651, 32458.0, 32562.67437325644, 32726.509102363485, 32815.50776738351, 33194.170145746546, 1140.766142940695, 1171.5723760827236, 1181.7518321152481, 1192.6124009696882, 1229.624964385853, 16964.74552881708, 17155.399561015303, 17179.0, 17274.222659980333, 17584.38454654081, 548981.0, 552696.0, 554475.0, 554648.0, 558122.0, 61513.0, 61785.07322390168, 61861.07208391878, 62107.0, 62274.0, 1356.0981947005132, 1390.7566175919173, 1405.9226742529054, 1415.7947097670985, 1418.8368337641098, 31642.525362119126, 32693.836530818146, 32938.67061329356, 33259.334813304085, 33775.66224337725, 52369.0, 53194.202086967955, 53239.733801330745, 53394.0, 53406.73296633492, 455756.0, 456516.0, 457960.0, 459242.0, 459549.0, 29997.250068748457, 30067.248318792204, 30275.394492110474, 30549.389012220076, 30591.847040765544, 47933.28100078432, 48118.0, 49728.0, 49763.50236497589, 50046.0, 41540.0, 41732.58267417287, 41796.58203417927, 42407.0, 43790.0, 41402.0, 41870.58129418667, 42108.789456052524, 43207.0, 43903.34144987891, 41542.1691566173, 42477.0, 43726.78136609297, 43802.12395752003, 46250.30624540567, 36879.63120368762, 37024.25951481009, 37533.62466375301, 37937.43093853539, 38210.42684359681, 29243.85378073096, 29615.851920740257, 29851.253718657208, 29897.70102298949, 30143.397132057675], "value": 20633.36741194586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.97172683775574, 437.7461072577905, 441.7410380415814, 442.45136031321164, 444.99110017799666, 18416.81583184168, 19130.808691913095, 19984.60030799385, 19999.100040498175, 20147.899260503676, 18744.81255187448, 19410.902945485253, 19563.804361956376, 19655.606887862235, 19778.901105494453, 5220.164773636219, 5417.052015897222, 5480.91778623321, 5495.120780675093, 5500.614956953015, 5387.595930305223, 5444.482774136451, 5454.127339625661, 5474.698891560983, 5835.912461313083, 5855.560832937525, 5855.648661080328, 5887.970560147215, 5888.057910734262, 5893.58744887858, 5633.830985070434, 5795.362510123883, 5807.651540907559, 5857.619254748449, 5900.675462849542, 5367.087595108841, 5382.650127741724, 5388.568914486871, 5392.541633961118, 5395.460453954613, 23341.0, 23997.0, 24344.417612855286, 24528.0, 24546.631800523006, 2425.9393515162087, 2445.6453814196843, 2453.4234454903085, 2457.3610861176044, 2917.705735660848, 10585.259031867772, 11027.889721102767, 11193.16051296156, 11539.59611413605, 11548.711282217928, 1897.5351038995534, 1994.870333428337, 2028.2799606139756, 2075.9723936651453, 2118.947026324339, 92471.53764231203, 92911.0, 94801.52599237028, 95494.0, 97011.0, 11832.585859494877, 12000.399980000964, 12112.273263604213, 12115.0, 12224.938875305566, 17358.39245626397, 17362.39231626887, 17377.131143442777, 17403.390881319094, 17445.651086978443, 8741.562921853882, 8989.235914947303, 9166.67916622915, 9238.67664631748, 9327.393719408217, 8856.070112638208, 8860.291176705978, 8876.600552975131, 9058.094190580889, 9086.409383390059, 4815.109204797123, 5048.747562621854, 5126.359205099363, 5129.820456284012, 5272.947270527322, 2121.0349291072525, 2133.4986278224605, 2159.157928407922, 2181.149351752818, 2201.735791705006, 967.2165545907837, 999.4602914426274, 1079.0361541993652, 1089.4443833644898, 1115.9051480624075, 20245.493862653257, 20492.18031278762, 20616.278430254868, 20818.791812081687, 21531.461713457287, 1009.2178561614661, 1058.5501162006117, 1093.2238110941162, 1100.0814320042693, 1136.755597546515, 10924.0, 11324.943375283236, 11390.772184556263, 11410.600628977945, 11453.484593193327, 529282.0, 533368.0, 538138.0, 538452.0, 539532.0, 92317.0, 94413.5279323599, 104807.4759626197, 106154.0, 111328.0, 1061.766411389493, 1097.9945100274608, 1104.7293413113678, 1104.7569534702352, 1108.2131686502673, 16406.753898691768, 16722.498325050266, 17005.744913826056, 17175.7423638643, 17388.652226955644, 44495.33257001212, 44853.32720009268, 45045.0, 45376.999999998676, 45862.0, 60414.69792651009, 64044.0, 64864.35135648583, 65100.674496627216, 65779.34220657732, 8926.821463570563, 9010.774730631525, 9156.313276504423, 9178.816423671622, 9312.674056407994, 9644.662436814679, 12751.744965100832, 13018.804717929428, 13033.15284506504, 13088.672783180496, 11464.426778660867, 11605.419729013347, 11605.6518304451, 11703.356315402734, 11734.94132529332, 10924.890751092387, 10961.890381096087, 11284.21010529255, 11313.377764222718, 11400.771984560428, 11538.0, 11565.132615054074, 11598.536058557564, 11974.760504789681, 11979.0, 9138.314626402913, 9263.120003599648, 9465.905340946503, 9475.54929102128, 9567.61729530811, 8543.743687689379, 8865.069167737294, 9067.09329067088, 10241.692749217535, 11650.88349116532], "value": 9645.988796155627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.2996186735036, 1543.5909483986743, 1737.6350966297077, 1850.6668799616073, 1864.9067546622666, 8127.390445716565, 8396.538190399526, 8793.692220772275, 9373.390729602579, 9474.526273686322, 8729.170728780771, 8890.244329232008, 9043.63825446983, 9217.76955576111, 9324.440533567991, 2537.0486067724605, 2548.9490210195786, 2555.4505781257026, 2564.833285836424, 2569.961450578243, 2456.852588844675, 2522.1928982725535, 2531.0508559290265, 2547.885345159463, 2556.897724091034, 2483.1681386735463, 2505.1607711416696, 2506.6616006839026, 2506.6616006839117, 2507.3480894967256, 2420.8426452280546, 2451.7180524239675, 2484.925452236436, 2484.981157725324, 2486.316263027664, 2427.1141033522813, 2439.597466418039, 2454.6808914841135, 2461.815363847719, 2468.4322605800585, 9252.814943701156, 9317.487538185396, 9319.90680093197, 9345.73832532613, 9431.15119639229, 5673.461021202979, 5755.0, 5796.797112101099, 5804.796832110898, 5809.88380232393, 3720.1257704439436, 3776.131489757344, 3805.1438426354125, 3820.36963900956, 3826.7754318618054, 1196.2702751321688, 1197.2457351868354, 1223.7858374784378, 1245.9688507787287, 1308.6074177746639, 12847.421866016051, 13092.149010314299, 13105.672358191026, 13133.27766972816, 13133.737325253536, 4993.101241776442, 5078.111330517145, 5157.226416037549, 5254.684718916801, 5312.389075256395, 10966.067884229771, 10999.285046471954, 11006.679198496231, 11042.779144417067, 11072.557097716162, 5838.8540286492325, 5843.094320380348, 5853.2976042875125, 5879.176915231871, 5880.294364676266, 4436.82252709888, 5168.689878607221, 5234.031704134747, 5258.0009798138235, 5340.732963351817, 4278.272693642089, 4314.935275970863, 4343.478782546114, 4379.5839395258035, 4380.6057454829215, 1413.0673755321643, 1416.4617445370693, 1424.985750142506, 1427.942882284697, 1430.8640679135465, 989.1740396768635, 991.2961797123978, 1010.5351538292321, 1015.2690063154517, 1018.33808024783, 6036.607620504653, 6117.938820611826, 6118.082287656887, 6183.938160618426, 6186.257649082139, 495.30657080087445, 497.7337124638374, 498.03381440006274, 505.1286530734527, 1068.1027936533194, 3940.133170702441, 4123.175364927027, 4156.56356082607, 4179.310413781753, 4250.511191212988, 11358.204925655291, 11551.0, 11580.76838463226, 11606.24559403636, 11649.359285239223, 11265.380404077854, 11353.716157096138, 11521.251118677259, 11533.653990380302, 11534.769304613861, 8599.226069653761, 8749.343799215085, 8865.157810008039, 8868.822623547492, 8883.0, 5856.180134781219, 6001.879962400815, 6045.274567051982, 6082.817515474543, 6096.786612468542, 10409.583616655249, 10419.06228439444, 10543.261971662218, 10547.841782373423, 10660.946695266784, 10481.633142839964, 10710.464476776286, 10734.570617175226, 10773.946130269298, 10864.674059778219, 7143.249958754256, 7391.8152046199275, 7539.585322807298, 7799.805004874924, 7863.685452581833, 8935.955320223356, 9214.953925230331, 9229.215516680888, 9239.983601803931, 9240.937292211212, 7773.961130194313, 7840.294373506412, 7844.64699088531, 8079.959600202196, 8090.1909809018625, 7843.0, 7898.2891539761695, 7960.880586791319, 8019.83960320802, 8209.179082091743, 7049.400800931979, 7133.750318738819, 7184.030155929092, 7185.173705023989, 7210.206877243604, 5223.373195216598, 5226.947730522798, 5229.869253268699, 5302.814401495929, 5352.866178345573, 5300.284461597635, 5348.598855085962, 5368.785248590013, 5399.190121481809, 5583.994880921473], "value": 4854.318748065544, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.89678993092, 360.49530657080084, 364.50427418710547, 365.7933267703749, 369.68761396619846, 5726.3128424589, 5728.6562806231605, 5794.536437085034, 5815.767369305228, 5820.0, 5500.339959204901, 5646.560127167567, 5655.604107712462, 5676.347220069693, 5698.518385219842, 4407.515173330947, 4418.204723149832, 4436.622887054604, 4464.374987501752, 4484.125595508877, 4455.509893911667, 4456.064226512436, 4468.262736648449, 4489.5285994970545, 4503.752293623849, 4410.0, 4445.8221671133115, 4450.688451808374, 4461.866144015685, 4467.5755803198645, 4317.913641727164, 4397.626201772853, 4423.889402764957, 4429.712068715523, 4433.733975961421, 3932.2304962766584, 3933.8033098345254, 3938.645521903014, 3941.600731740248, 3943.3493473576827, 5493.148561972901, 5514.889702205974, 5556.333240011184, 5561.165825126223, 5564.972175139139, 5018.222175562793, 5072.391313042422, 5073.543381095719, 5097.8215762448135, 5099.5410413063, 5876.147958546029, 5900.616459930091, 5914.2015827863115, 5919.112133180014, 5935.258092738408, 4265.829366825324, 4363.847265345697, 4370.169667763115, 4373.1472362888935, 4381.9342709859375, 5934.258217722785, 6119.908201376938, 6163.1063495793305, 6178.7219575119225, 6188.350223226586, 4350.086481838786, 4364.781760911942, 4372.453443319585, 4386.758728269912, 4401.8555175654565, 4354.325079612665, 4398.69209155356, 4402.4056752338665, 4421.358902959118, 4430.446194225722, 4913.0, 5018.673786203885, 5030.37120359955, 5053.7473126344275, 5095.490450954949, 5930.9406905931255, 5935.584509084322, 5936.881262374728, 5957.374475680078, 5968.731407086605, 1464.4727897956727, 1491.4407097338499, 1496.565995861188, 1499.5576304989836, 1505.9397624095132, 977.4672803322206, 1023.5445226874118, 1025.4565080507343, 1045.9790804183874, 1050.6900464363032, 5583.29709438617, 5589.720513974285, 5612.316305108451, 5643.35101463337, 5655.462731040545, 5905.43898329658, 5919.756851061239, 5919.845630102175, 5935.584509084322, 5966.820995370059, 5316.255724198615, 5479.205515200274, 5524.392316845144, 5553.4724201201625, 5673.5461163107675, 3144.5440411140257, 3146.8269245191736, 3151.353972435645, 3153.8896138635496, 3179.300553878143, 5905.76376944926, 6093.969530152321, 6101.389861013952, 6135.9079613805825, 6148.077788331786, 5930.495907847795, 5965.0, 5972.0, 5978.491828194652, 6064.211652485237, 6072.423119803611, 6075.453209211104, 6082.726277317532, 6116.938830611726, 6159.414855588801, 5791.422816846463, 5809.883802323845, 5872.530197584098, 5902.852428689317, 5958.582899197015, 5690.971545142248, 5791.652500849962, 5814.622049566765, 5828.59199856006, 5831.650100993954, 6087.447700836258, 6273.560850740404, 6291.96854015727, 6335.1447554579545, 6339.683015849281, 4415.116976604756, 4465.330200469825, 4475.731456112644, 4475.77744024302, 4491.73049617024, 6050.273967123973, 6159.414855588712, 6185.6391593849285, 6246.187995560548, 6270.773875274212, 5959.404059594006, 5965.85229317454, 5973.970130149321, 5980.730867110903, 5993.790217342372, 5872.0, 5927.347991720821, 5974.372690867396, 5978.730957106854, 6009.90985135232, 5876.676782776988, 5903.605426879647, 5926.081352477519, 5928.733207005609, 5933.486960824962, 6020.976434006142, 6040.2147720797775, 6043.909341359971, 6052.485538729257, 6068.21113255274, 5712.428757124254, 5835.103591332919, 5856.736446859816, 5922.318933322723, 5934.495567876779], "value": 4523.694694343141, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.3028604541962, 792.5324058805304, 813.4265342933232, 840.3571267979996, 877.3726785348476, 15353.232338383092, 16345.836541634595, 16423.83576164238, 16457.83542164578, 16464.91767541162, 13727.65680857979, 13880.722385552283, 13929.512467063654, 14010.299485025733, 14118.0, 836.7280633794026, 839.1566475691922, 843.7173546861809, 847.6736456464243, 849.049065047148, 846.3313981954249, 849.8682704180831, 850.5662112322728, 851.2849206666399, 852.7186028610574, 889.6263569300909, 892.6072528087653, 893.2987604730288, 894.0880302091863, 895.212213252337, 888.6711916590903, 888.9955550222207, 889.5552223888056, 893.3880291999968, 894.874717539545, 646.385933363302, 648.9415952564292, 654.9443297319733, 656.2059907511916, 658.1246941567704, 13384.732305353935, 13391.397387117602, 13406.597802065953, 13419.731605367935, 13433.261170635611, 12527.123101382907, 12715.936420317932, 12767.489300428064, 12811.615651530468, 12835.0, 10758.0, 10779.137668986463, 10818.0, 10836.783264334668, 10943.671689849318, 3762.4168253920684, 3803.182315802088, 3812.752171108869, 3847.8460861565504, 3931.82306796192, 65893.0, 66467.0, 67119.32880671228, 68786.9999999995, 70549.0, 9268.0, 9856.802863942825, 9891.505424728735, 9923.305368624127, 9963.302568820258, 18447.354342597944, 18470.538236544195, 18654.253829846653, 18851.528711782314, 19088.61822763537, 7515.6242187891485, 7912.0901096374655, 7970.6413211405625, 8035.919640803634, 8203.630836612367, 4325.394444777734, 4542.091581683677, 4582.221022426195, 4675.18184317743, 4749.810007599726, 3553.1117220694828, 3698.14942563212, 3698.68561172298, 3711.2763011213096, 3720.2931443025736, 640.4108220437209, 641.6246495799916, 643.3116565275204, 649.3117295666608, 650.0931200974613, 776.3556248313886, 782.8708263136518, 798.6885114805231, 812.5937031484258, 833.8582440984926, 8832.690855820145, 9393.57728902201, 9477.383970041925, 9569.058682324478, 9683.854742178873, 697.7545082028555, 747.3311386309332, 761.2235519769804, 767.1522967121363, 768.3507436216388, 4300.548442413564, 4406.294992801137, 4446.488653804854, 4450.777461126931, 4483.21543729846, 92505.53747231221, 93334.53332733293, 93549.53225233966, 95052.0, 97230.0, 78363.21636783674, 79100.0, 81467.0, 82110.0, 82186.58906705429, 69939.30060699327, 72576.0, 75253.0, 75580.24419755842, 75924.62037689776, 8694.39139260271, 8752.431091979, 8847.46915185091, 8849.247813935888, 9061.365704400629, 48777.75611121922, 49071.50928490669, 49609.50390496193, 50660.24009639932, 51480.48519514907, 56946.0, 59853.700731497804, 63190.0, 67506.66246668735, 70872.29127708657, 12900.548480803127, 12900.93549532284, 13018.0, 13139.0, 13173.60479185626, 13983.790243146157, 14097.929510352382, 14254.643633909236, 14613.0, 14698.63253418673, 13246.933765331112, 13311.600651980456, 13453.46186152582, 13631.454741810614, 13737.24445155526, 13325.466981320638, 13726.382312795748, 13922.373493193034, 14004.579862604138, 14354.425822966965, 12707.237565746085, 13155.868441315464, 13381.264030478027, 13480.123791953492, 13684.31578421055, 10537.315074520131, 10584.0, 10685.198610104118, 10856.45717714127, 10881.129509639368, 10464.790704185722, 10828.242023058625, 11036.061934735637, 11074.169437292074, 11091.611793587186], "value": 7285.3037462999455, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1471.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 113.0, 112.0, 111.0, 112.0, 111.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 120.0, 174.0, 120.0, 119.0, 118.0, 120.0, 142.0, 120.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 164.0, 160.0, 162.0, 161.0, 163.0, 162.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 119.0, 77.0, 76.0, 76.0, 76.0, 100.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 113.0, 81.0, 82.0, 81.0, 109.0, 81.0, 82.0, 117.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 120.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 85.0, 84.0, 85.0, 86.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 55.0, 56.0, 52.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 64.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 84.0, 80.0, 76.0, 76.0, 75.0, 76.0, 76.0, 74.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 126.0, 122.0, 126.0, 139.0, 135.0, 122.0, 176.0, 124.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 160.0, 158.0, 158.0, 159.0, 157.0, 155.0, 156.0, 155.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 69.0, 69.0, 63.0, 63.0, 65.0, 61.0, 66.0, 65.0], "value": 64.7, "unit": "score"}]}]} 09:23:11 INFO - Return code: 0 09:23:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:23:11 ERROR - # TBPL SUCCESS # 09:23:11 INFO - Running post-action listener: _resource_record_post_action 09:23:11 INFO - [mozharness: 2016-12-21 17:23:11.187305Z] Finished run-tests step (success) 09:23:11 INFO - Running post-run listener: _resource_record_post_run 09:23:11 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 355540992; Read time: 36; Write time: 253608 09:23:11 INFO - TinderboxPrint: CPU usage
13.3% 09:23:11 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 09:23:11 INFO - TinderboxPrint: I/O write bytes / time
355,540,992 / 253,608 09:23:11 INFO - TinderboxPrint: CPU idle
8,235.3 (86.7%) 09:23:11 INFO - TinderboxPrint: CPU user
1,209.2 (12.7%) 09:23:11 INFO - TinderboxPrint: Swap in / out
0 / 0 09:23:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107302912; Read time: 0; Write time: 75804 09:23:11 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246972416; Read time: 20; Write time: 177672 09:23:11 INFO - Running post-run listener: _upload_blobber_files 09:23:11 INFO - Blob upload gear active. 09:23:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:23:11 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 09:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:23:12 INFO - (blobuploader) - INFO - Open directory for files ... 09:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:12 INFO - (blobuploader) - INFO - Done attempting. 09:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:23:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:13 INFO - (blobuploader) - INFO - Done attempting. 09:23:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:23:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:23:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:17 INFO - (blobuploader) - INFO - Done attempting. 09:23:17 INFO - (blobuploader) - INFO - Iteration through files over. 09:23:17 INFO - Return code: 0 09:23:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:23:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:23:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ba73b2e5ff6bf0583a35689bac4b17d2c2e6d5a84f535ce92a961c829fd73b3a8057f429373d03837d4ec416c49272851f9a3f06824d27861b6962fba4060ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5711eabe7ef1eca491f6fd9d41c2c365e35c378255dcd542d5458c5cacc68bd34fb1a7b3e90a3af46e762da1858c2b6e841acbf5b190ce4d12f25275af9bfdfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4815a1a6d120b6756a84bee45097d3ef2b69c6ecc24fcac7af6dca085bb852fb278bad068ec019f6c80125f9336564497f8e241cf844f814d527a65962b846ec"} 09:23:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:23:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:23:17 INFO - Contents: 09:23:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ba73b2e5ff6bf0583a35689bac4b17d2c2e6d5a84f535ce92a961c829fd73b3a8057f429373d03837d4ec416c49272851f9a3f06824d27861b6962fba4060ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5711eabe7ef1eca491f6fd9d41c2c365e35c378255dcd542d5458c5cacc68bd34fb1a7b3e90a3af46e762da1858c2b6e841acbf5b190ce4d12f25275af9bfdfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4815a1a6d120b6756a84bee45097d3ef2b69c6ecc24fcac7af6dca085bb852fb278bad068ec019f6c80125f9336564497f8e241cf844f814d527a65962b846ec"} 09:23:17 INFO - Running post-run listener: copy_logs_to_upload_dir 09:23:17 INFO - Copying logs to upload dir... 09:23:17 INFO - mkdir: /builds/slave/test/build/upload/logs 09:23:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.662462 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-21 09:23:17.264936) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 09:23:17.268437) ========= 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=652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ba73b2e5ff6bf0583a35689bac4b17d2c2e6d5a84f535ce92a961c829fd73b3a8057f429373d03837d4ec416c49272851f9a3f06824d27861b6962fba4060ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5711eabe7ef1eca491f6fd9d41c2c365e35c378255dcd542d5458c5cacc68bd34fb1a7b3e90a3af46e762da1858c2b6e841acbf5b190ce4d12f25275af9bfdfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4815a1a6d120b6756a84bee45097d3ef2b69c6ecc24fcac7af6dca085bb852fb278bad068ec019f6c80125f9336564497f8e241cf844f814d527a65962b846ec"} build_url:https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/GbR12I7JRXKy3IprzhncKw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ba73b2e5ff6bf0583a35689bac4b17d2c2e6d5a84f535ce92a961c829fd73b3a8057f429373d03837d4ec416c49272851f9a3f06824d27861b6962fba4060ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5711eabe7ef1eca491f6fd9d41c2c365e35c378255dcd542d5458c5cacc68bd34fb1a7b3e90a3af46e762da1858c2b6e841acbf5b190ce4d12f25275af9bfdfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4815a1a6d120b6756a84bee45097d3ef2b69c6ecc24fcac7af6dca085bb852fb278bad068ec019f6c80125f9336564497f8e241cf844f814d527a65962b846ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 09:23:17.294731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 09:23:17.295073) ========= 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=652eb03db935cfc1c15ebda0000001ad-1482339758.984735-683410976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 09:23:17.379166) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 09:23:17.379479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 09:23:17.379774) ========= ========= Total master_lag: 0.18 =========