builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1480115338.52 results: success (0) buildid: 20161125122519 builduid: 78dbc2e280e34d38b045fbe066f3a206 revision: bafd3cf3970490e029351e6befa56667f568f85f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:58.515506) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:58.516127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:58.516405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:58.553399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:58.553740) ========= 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=1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 15:08:58-- 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% 220M=0s 2016-11-25 15:08:58 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160492 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:58.728576) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:58.728898) ========= 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=1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017300 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:58.778456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:58.778776) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bafd3cf3970490e029351e6befa56667f568f85f --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 bafd3cf3970490e029351e6befa56667f568f85f --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=1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 15:08:59,012 truncating revision to first 12 chars 2016-11-25 15:08:59,012 Setting DEBUG logging. 2016-11-25 15:08:59,012 attempt 1/10 2016-11-25 15:08:59,012 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bafd3cf39704?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 15:08:59,346 unpacking tar archive at: mozilla-aurora-bafd3cf39704/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:59.443524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:59.443811) ========= script_repo_revision: bafd3cf3970490e029351e6befa56667f568f85f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:59.444188) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:59.444448) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 15:08:59.452340) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-25 15:08:59.452633) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:08:59 INFO - MultiFileLogger online at 20161125 15:08:59 in /builds/slave/test 15:08:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:08:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:08:59 INFO - {'append_to_log': False, 15:08:59 INFO - 'base_work_dir': '/builds/slave/test', 15:08:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:08:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:08:59 INFO - 'branch': 'Mozilla-Aurora', 15:08:59 INFO - 'buildbot_json_path': 'buildprops.json', 15:08:59 INFO - 'config_files': ('talos/linux_config.py',), 15:08:59 INFO - 'default_actions': ('clobber', 15:08:59 INFO - 'read-buildbot-config', 15:08:59 INFO - 'download-and-extract', 15:08:59 INFO - 'populate-webroot', 15:08:59 INFO - 'create-virtualenv', 15:08:59 INFO - 'install', 15:08:59 INFO - 'run-tests'), 15:08:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:08:59 INFO - 'download_minidump_stackwalk': True, 15:08:59 INFO - 'download_symbols': 'ondemand', 15:08:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:08:59 INFO - 'tooltool.py': '/tools/tooltool.py', 15:08:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:08:59 INFO - '/tools/misc-python/virtualenv.py')}, 15:08:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:08:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:08:59 INFO - 'installer_path': 'installer.exe', 15:08:59 INFO - 'log_level': 'info', 15:08:59 INFO - 'log_name': 'talos', 15:08:59 INFO - 'log_to_console': True, 15:08:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:08:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:08:59 INFO - 'opt_config_files': (), 15:08:59 INFO - 'pip_index': False, 15:08:59 INFO - 'sps_profile': False, 15:08:59 INFO - 'sps_profile_interval': 0, 15:08:59 INFO - 'suite': 'dromaeojs', 15:08:59 INFO - 'system_bits': '32', 15:08:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:08:59 INFO - 'title': 'talos-linux64-ix-027', 15:08:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:08:59 INFO - 'use_talos_json': True, 15:08:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:08:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:08:59 INFO - 'work_dir': 'build'} 15:08:59 INFO - [mozharness: 2016-11-25 23:08:59.783935Z] Running clobber step. 15:08:59 INFO - Running pre-action listener: _resource_record_pre_action 15:08:59 INFO - Running main action method: clobber 15:08:59 INFO - rmtree: /builds/slave/test/build 15:08:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:09:00 INFO - Running post-action listener: _resource_record_post_action 15:09:00 INFO - [mozharness: 2016-11-25 23:09:00.752135Z] Finished clobber step (success) 15:09:00 INFO - [mozharness: 2016-11-25 23:09:00.752233Z] Running read-buildbot-config step. 15:09:00 INFO - Running pre-action listener: _resource_record_pre_action 15:09:00 INFO - Running main action method: read_buildbot_config 15:09:00 INFO - Using buildbot properties: 15:09:00 INFO - { 15:09:00 INFO - "project": "", 15:09:00 INFO - "product": "firefox", 15:09:00 INFO - "script_repo_revision": "production", 15:09:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:09:00 INFO - "repository": "", 15:09:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:09:00 INFO - "buildid": "20161125122519", 15:09:00 INFO - "pgo_build": "True", 15:09:00 INFO - "basedir": "/builds/slave/test", 15:09:00 INFO - "buildnumber": 618, 15:09:00 INFO - "slavename": "talos-linux64-ix-027", 15:09:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:09:00 INFO - "platform": "ubuntu64_hw", 15:09:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:09:00 INFO - "branch": "mozilla-aurora", 15:09:00 INFO - "repo_path": "releases/mozilla-aurora", 15:09:00 INFO - "revision": "bafd3cf3970490e029351e6befa56667f568f85f", 15:09:00 INFO - "stage_platform": "linux64-pgo", 15:09:00 INFO - "builduid": "78dbc2e280e34d38b045fbe066f3a206", 15:09:00 INFO - "slavebuilddir": "test" 15:09:00 INFO - } 15:09:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 15:09:00 INFO - Running post-action listener: _resource_record_post_action 15:09:00 INFO - [mozharness: 2016-11-25 23:09:00.754633Z] Finished read-buildbot-config step (success) 15:09:00 INFO - [mozharness: 2016-11-25 23:09:00.754721Z] Running download-and-extract step. 15:09:00 INFO - Running pre-action listener: _resource_record_pre_action 15:09:00 INFO - Running main action method: download_and_extract 15:09:00 INFO - mkdir: /builds/slave/test/build/tests 15:09: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')]} 15:09:00 INFO - trying https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:09:00 INFO - Downloading https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/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 15:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/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 15:09:01 INFO - Downloaded 1361 bytes. 15:09:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:09:01 INFO - Using the following test package requirements: 15:09:01 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:09:01 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:09:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:09:01 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:09:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:09:01 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:09:01 INFO - u'jsshell-linux-x86_64.zip'], 15:09:01 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:09:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:09:01 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:09:01 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:09:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:09:01 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:09:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:09:01 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:09:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:09:01 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:09:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:09:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:09:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:09:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:09:01 INFO - Fetch https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:09:01 INFO - Http code: 200 15:09:01 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 15:09:01 INFO - x-amz-cf-id: rmcTHgFJUtrWeVDyqTmQ6ckmPD94Xv-CqbG2iJQWyoiKpIZ2rEeb8g== 15:09:01 INFO - x-amz-version-id: oGdPCP_UdXFw7YXFNu43Mrh7Oq.5J0Ke 15:09:02 INFO - Expected file size: 21951245 15:09:02 INFO - Obtained file size: 21951245 15:09:06 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 15:09:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:09:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:09:06 INFO - Fetch https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:09:07 INFO - Http code: 200 15:09:07 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 15:09:07 INFO - x-amz-cf-id: iJLma9maKMLAc15CQeJnQwLWiht3uDOpw0bnfMfIlQbbOBPTUccgnA== 15:09:07 INFO - x-amz-version-id: oGdPCP_UdXFw7YXFNu43Mrh7Oq.5J0Ke 15:09:07 INFO - Expected file size: 21951245 15:09:07 INFO - Obtained file size: 21951245 15:09:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 15:09:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:09:11 INFO - Fetch https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 15:09:12 INFO - Http code: 200 15:09:12 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 15:09:12 INFO - x-amz-cf-id: MceN6LeRyLyCO7u7gkWs5yVK7ny-nGKhoThztUU55likX7wYcWh8mg== 15:09:12 INFO - x-amz-version-id: JaUZyEkJQ8YOTEzJbWJg1hviPNWFTed0 15:09:13 INFO - Expected file size: 14409038 15:09:13 INFO - Obtained file size: 14409038 15:09:13 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')]} 15:09:13 INFO - trying https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:09:13 INFO - Downloading https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/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 15:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/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 15:09:16 INFO - Downloaded 63968088 bytes. 15:09:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:09:16 INFO - mkdir: /builds/slave/test/properties 15:09:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:09:16 INFO - Writing to file /builds/slave/test/properties/build_url 15:09:16 INFO - Contents: 15:09:16 INFO - build_url:https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:09:16 INFO - Running post-action listener: _resource_record_post_action 15:09:16 INFO - Running post-action listener: set_extra_try_arguments 15:09:16 INFO - [mozharness: 2016-11-25 23:09:16.727433Z] Finished download-and-extract step (success) 15:09:16 INFO - [mozharness: 2016-11-25 23:09:16.727695Z] Running populate-webroot step. 15:09:16 INFO - Running pre-action listener: _resource_record_pre_action 15:09:16 INFO - Running main action method: populate_webroot 15:09:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:09:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:09:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:09:16 INFO - '--tppagecycles', 15:09:16 INFO - '7'], 15:09:16 INFO - 'tests': ['tsvgm']}}, 15:09:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:09:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:09:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:09:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:09:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:16 INFO - 'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:09:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:09:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:16 INFO - 'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['damp', 'tps']}, 15:09:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:16 INFO - 'tests': ['damp', 'tps']}, 15:09:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['dromaeo_dom']}, 15:09:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:09:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['basic_compositor_video']}, 15:09:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:09:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['a11yr', 15:09:16 INFO - 'ts_paint', 15:09:16 INFO - 'tpaint', 15:09:16 INFO - 'sessionrestore', 15:09:16 INFO - 'sessionrestore_no_auto_restore', 15:09:16 INFO - 'tabpaint']}, 15:09:16 INFO - 'other-e10s': {'tests': ['a11yr', 15:09:16 INFO - 'ts_paint', 15:09:16 INFO - 'tpaint', 15:09:16 INFO - 'sessionrestore', 15:09:16 INFO - 'sessionrestore_no_auto_restore', 15:09:16 INFO - 'tabpaint']}, 15:09:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:09:16 INFO - 'ts_paint', 15:09:16 INFO - 'tpaint', 15:09:16 INFO - 'sessionrestore', 15:09:16 INFO - 'sessionrestore_no_auto_restore', 15:09:16 INFO - 'tabpaint']}, 15:09:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:09:16 INFO - 'ts_paint', 15:09:16 INFO - 'tpaint', 15:09:16 INFO - 'sessionrestore', 15:09:16 INFO - 'sessionrestore_no_auto_restore', 15:09:16 INFO - 'tabpaint']}, 15:09:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['a11yr', 15:09:16 INFO - 'ts_paint', 15:09:16 INFO - 'tpaint', 15:09:16 INFO - 'sessionrestore', 15:09:16 INFO - 'sessionrestore_no_auto_restore', 15:09:16 INFO - 'tabpaint']}, 15:09:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['a11yr', 15:09:16 INFO - 'ts_paint', 15:09:16 INFO - 'tpaint', 15:09:16 INFO - 'sessionrestore', 15:09:16 INFO - 'sessionrestore_no_auto_restore', 15:09:16 INFO - 'tabpaint']}, 15:09:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['tsvgx', 15:09:16 INFO - 'tsvgr_opacity', 15:09:16 INFO - 'tart', 15:09:16 INFO - 'tscrollx', 15:09:16 INFO - 'cart']}, 15:09:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:09:16 INFO - 'tsvgr_opacity', 15:09:16 INFO - 'tart', 15:09:16 INFO - 'tscrollx', 15:09:16 INFO - 'cart']}, 15:09:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:16 INFO - 'talos_options': ['--disable-e10s'], 15:09:16 INFO - 'tests': ['tp5o']}, 15:09:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:16 INFO - 'tests': ['tp5o']}, 15:09:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:16 INFO - 'talos_options': ['--disable-e10s', 15:09:16 INFO - '--xperf_path', 15:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:09:16 INFO - 'tests': ['tp5n']}, 15:09:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:09:16 INFO - 'talos_options': ['--xperf_path', 15:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:09:16 INFO - 'tests': ['tp5n']}}, 15:09:16 INFO - 'talos.zip': {'path': '', 15:09:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:09:16 INFO - Running post-action listener: _resource_record_post_action 15:09:16 INFO - [mozharness: 2016-11-25 23:09:16.745969Z] Finished populate-webroot step (success) 15:09:16 INFO - [mozharness: 2016-11-25 23:09:16.746056Z] Running create-virtualenv step. 15:09:16 INFO - Running pre-action listener: _resource_record_pre_action 15:09:16 INFO - Running main action method: create_virtualenv 15:09:16 INFO - Creating virtualenv /builds/slave/test/build/venv 15:09:16 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 15:09:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:09:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:09:16 INFO - Using real prefix '/usr' 15:09:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:09:17 INFO - Installing distribute.............................................................................................................................................................................................done. 15:09:19 INFO - Installing pip.................done. 15:09:19 INFO - Return code: 0 15:09:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:09:19 INFO - Reading from file tmpfile_stdout 15:09:19 INFO - Output received: 15:09:19 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) 15:09:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:09: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')]} 15:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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')]} 15:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09: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', 'pip>=1.5'] in /builds/slave/test/build 15:09: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 pip>=1.5 15:09:19 INFO - Using env: {'DISPLAY': ':0', 15:09:19 INFO - 'HOME': '/home/cltbld', 15:09:19 INFO - 'LANG': 'en_US.UTF-8', 15:09:19 INFO - 'LANGUAGE': 'en_US:en', 15:09:19 INFO - 'LOGNAME': 'cltbld', 15:09:19 INFO - 'MAIL': '/var/mail/cltbld', 15:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:19 INFO - 'MOZ_NO_REMOTE': '1', 15:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:19 INFO - 'NO_EM_RESTART': '1', 15:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:19 INFO - 'PWD': '/builds/slave/test', 15:09:19 INFO - 'SHELL': '/bin/bash', 15:09:19 INFO - 'SHLVL': '1', 15:09:19 INFO - 'TERM': 'linux', 15:09:19 INFO - 'TMOUT': '86400', 15:09:19 INFO - 'USER': 'cltbld', 15:09:19 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:19 INFO - '_': '/tools/buildbot/bin/python'} 15:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:19 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 15:09:19 INFO - Cleaning up... 15:09:19 INFO - Return code: 0 15:09:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:09: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')]} 15:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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')]} 15:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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', '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 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:09: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 psutil>=3.1.1 15:09:19 INFO - Using env: {'DISPLAY': ':0', 15:09:19 INFO - 'HOME': '/home/cltbld', 15:09:19 INFO - 'LANG': 'en_US.UTF-8', 15:09:19 INFO - 'LANGUAGE': 'en_US:en', 15:09:19 INFO - 'LOGNAME': 'cltbld', 15:09:19 INFO - 'MAIL': '/var/mail/cltbld', 15:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:19 INFO - 'MOZ_NO_REMOTE': '1', 15:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:19 INFO - 'NO_EM_RESTART': '1', 15:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:19 INFO - 'PWD': '/builds/slave/test', 15:09:19 INFO - 'SHELL': '/bin/bash', 15:09:19 INFO - 'SHLVL': '1', 15:09:19 INFO - 'TERM': 'linux', 15:09:19 INFO - 'TMOUT': '86400', 15:09:19 INFO - 'USER': 'cltbld', 15:09:19 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:19 INFO - '_': '/tools/buildbot/bin/python'} 15:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:19 INFO - Downloading/unpacking psutil>=3.1.1 15:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:09:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:09:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:09:22 INFO - Installing collected packages: psutil 15:09:22 INFO - Running setup.py install for psutil 15:09:22 INFO - building 'psutil._psutil_linux' extension 15:09:22 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 15:09:22 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 15:09:22 INFO - building 'psutil._psutil_posix' extension 15:09:22 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 15:09:22 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 15:09:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:09:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:09:22 INFO - Successfully installed psutil 15:09:22 INFO - Cleaning up... 15:09:22 INFO - Return code: 0 15:09:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:09:22 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')]} 15:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:22 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')]} 15:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:22 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 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09:22 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 15:09:22 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 15:09:22 INFO - Using env: {'DISPLAY': ':0', 15:09:22 INFO - 'HOME': '/home/cltbld', 15:09:22 INFO - 'LANG': 'en_US.UTF-8', 15:09:22 INFO - 'LANGUAGE': 'en_US:en', 15:09:22 INFO - 'LOGNAME': 'cltbld', 15:09:22 INFO - 'MAIL': '/var/mail/cltbld', 15:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:22 INFO - 'MOZ_NO_REMOTE': '1', 15:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:22 INFO - 'NO_EM_RESTART': '1', 15:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:22 INFO - 'PWD': '/builds/slave/test', 15:09:22 INFO - 'SHELL': '/bin/bash', 15:09:22 INFO - 'SHLVL': '1', 15:09:22 INFO - 'TERM': 'linux', 15:09:22 INFO - 'TMOUT': '86400', 15:09:22 INFO - 'USER': 'cltbld', 15:09:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:22 INFO - '_': '/tools/buildbot/bin/python'} 15:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:09:24 INFO - Installing collected packages: mozsystemmonitor 15:09:24 INFO - Running setup.py install for mozsystemmonitor 15:09:24 INFO - Successfully installed mozsystemmonitor 15:09:24 INFO - Cleaning up... 15:09:24 INFO - Return code: 0 15:09:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:24 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 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09:24 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 15:09:24 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 15:09:24 INFO - Using env: {'DISPLAY': ':0', 15:09:24 INFO - 'HOME': '/home/cltbld', 15:09:24 INFO - 'LANG': 'en_US.UTF-8', 15:09:24 INFO - 'LANGUAGE': 'en_US:en', 15:09:24 INFO - 'LOGNAME': 'cltbld', 15:09:24 INFO - 'MAIL': '/var/mail/cltbld', 15:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:24 INFO - 'MOZ_NO_REMOTE': '1', 15:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:24 INFO - 'NO_EM_RESTART': '1', 15:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:24 INFO - 'PWD': '/builds/slave/test', 15:09:24 INFO - 'SHELL': '/bin/bash', 15:09:24 INFO - 'SHLVL': '1', 15:09:24 INFO - 'TERM': 'linux', 15:09:24 INFO - 'TMOUT': '86400', 15:09:24 INFO - 'USER': 'cltbld', 15:09:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:24 INFO - '_': '/tools/buildbot/bin/python'} 15:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:25 INFO - Downloading/unpacking jsonschema==2.5.1 15:09:25 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 15:09:25 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 15:09:25 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 15:09:25 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 15:09:25 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 15:09:25 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 15:09:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:09:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:09:27 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 15:09:27 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 15:09:27 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 15:09:27 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 15:09:27 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 15:09:27 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 15:09:27 INFO - Downloading functools32-3.2.3-2.tar.gz 15:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:09:27 INFO - warning: no files found matching '*.txt' 15:09:27 INFO - no previously-included directories found matching 'build' 15:09:27 INFO - no previously-included directories found matching 'dist' 15:09:27 INFO - no previously-included directories found matching '.git*' 15:09:27 INFO - Installing collected packages: jsonschema, functools32 15:09:27 INFO - Running setup.py install for functools32 15:09:27 INFO - warning: no files found matching '*.txt' 15:09:27 INFO - no previously-included directories found matching 'build' 15:09:27 INFO - no previously-included directories found matching 'dist' 15:09:27 INFO - no previously-included directories found matching '.git*' 15:09:27 INFO - Successfully installed jsonschema functools32 15:09:27 INFO - Cleaning up... 15:09:27 INFO - Return code: 0 15:09:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:27 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 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09:27 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 15:09:27 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 15:09:27 INFO - Using env: {'DISPLAY': ':0', 15:09:27 INFO - 'HOME': '/home/cltbld', 15:09:27 INFO - 'LANG': 'en_US.UTF-8', 15:09:27 INFO - 'LANGUAGE': 'en_US:en', 15:09:27 INFO - 'LOGNAME': 'cltbld', 15:09:27 INFO - 'MAIL': '/var/mail/cltbld', 15:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:27 INFO - 'MOZ_NO_REMOTE': '1', 15:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:27 INFO - 'NO_EM_RESTART': '1', 15:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:27 INFO - 'PWD': '/builds/slave/test', 15:09:27 INFO - 'SHELL': '/bin/bash', 15:09:27 INFO - 'SHLVL': '1', 15:09:27 INFO - 'TERM': 'linux', 15:09:27 INFO - 'TMOUT': '86400', 15:09:27 INFO - 'USER': 'cltbld', 15:09:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:27 INFO - '_': '/tools/buildbot/bin/python'} 15:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:09:27 INFO - Cleaning up... 15:09:27 INFO - Return code: 0 15:09:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:27 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 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09:27 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 15:09:27 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 15:09:27 INFO - Using env: {'DISPLAY': ':0', 15:09:27 INFO - 'HOME': '/home/cltbld', 15:09:27 INFO - 'LANG': 'en_US.UTF-8', 15:09:27 INFO - 'LANGUAGE': 'en_US:en', 15:09:27 INFO - 'LOGNAME': 'cltbld', 15:09:27 INFO - 'MAIL': '/var/mail/cltbld', 15:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:27 INFO - 'MOZ_NO_REMOTE': '1', 15:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:27 INFO - 'NO_EM_RESTART': '1', 15:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:27 INFO - 'PWD': '/builds/slave/test', 15:09:27 INFO - 'SHELL': '/bin/bash', 15:09:27 INFO - 'SHLVL': '1', 15:09:27 INFO - 'TERM': 'linux', 15:09:27 INFO - 'TMOUT': '86400', 15:09:27 INFO - 'USER': 'cltbld', 15:09:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:27 INFO - '_': '/tools/buildbot/bin/python'} 15:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:28 INFO - Downloading/unpacking blobuploader==1.2.4 15:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:29 INFO - Downloading blobuploader-1.2.4.tar.gz 15:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:09:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:09:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 INFO - Downloading docopt-0.6.1.tar.gz 15:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:09:30 INFO - Installing collected packages: blobuploader, requests, docopt 15:09:30 INFO - Running setup.py install for blobuploader 15:09:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:09:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:09:30 INFO - Running setup.py install for requests 15:09:31 INFO - Running setup.py install for docopt 15:09:31 INFO - Successfully installed blobuploader requests docopt 15:09:31 INFO - Cleaning up... 15:09:31 INFO - Return code: 0 15:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:09:31 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')]} 15:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:31 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')]} 15:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:31 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 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09:31 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 15:09:31 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 15:09:31 INFO - Using env: {'DISPLAY': ':0', 15:09:31 INFO - 'HOME': '/home/cltbld', 15:09:31 INFO - 'LANG': 'en_US.UTF-8', 15:09:31 INFO - 'LANGUAGE': 'en_US:en', 15:09:31 INFO - 'LOGNAME': 'cltbld', 15:09:31 INFO - 'MAIL': '/var/mail/cltbld', 15:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:31 INFO - 'MOZ_NO_REMOTE': '1', 15:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:31 INFO - 'NO_EM_RESTART': '1', 15:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:31 INFO - 'PWD': '/builds/slave/test', 15:09:31 INFO - 'SHELL': '/bin/bash', 15:09:31 INFO - 'SHLVL': '1', 15:09:31 INFO - 'TERM': 'linux', 15:09:31 INFO - 'TMOUT': '86400', 15:09:31 INFO - 'USER': 'cltbld', 15:09:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:31 INFO - '_': '/tools/buildbot/bin/python'} 15:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:09:31 INFO - Running setup.py (path:/tmp/pip-xgWCo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:09:31 INFO - Running setup.py (path:/tmp/pip-Poi7NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:09:31 INFO - Running setup.py (path:/tmp/pip-kcCxb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:09:31 INFO - Running setup.py (path:/tmp/pip-jOpd9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:09:31 INFO - Running setup.py (path:/tmp/pip-5GBAIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:09:31 INFO - Running setup.py (path:/tmp/pip-HFEQ75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:09:32 INFO - Running setup.py (path:/tmp/pip-nlYGLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:09:32 INFO - Running setup.py (path:/tmp/pip-7tpkeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:09:32 INFO - Running setup.py (path:/tmp/pip-cnOO5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:09:32 INFO - Running setup.py (path:/tmp/pip-nGqsL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:09:32 INFO - Running setup.py (path:/tmp/pip-mU5PtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:09:32 INFO - Running setup.py (path:/tmp/pip-luq5ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:09:32 INFO - Running setup.py (path:/tmp/pip-69Xrig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:09:32 INFO - Running setup.py (path:/tmp/pip-zSVsXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:32 INFO - Running setup.py (path:/tmp/pip-ACjEnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:09:32 INFO - Running setup.py (path:/tmp/pip-wAnvZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:09:32 INFO - Running setup.py (path:/tmp/pip-j53i6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:09:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:09:32 INFO - Running setup.py install for manifestparser 15:09:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:09:32 INFO - Running setup.py install for mozcrash 15:09:33 INFO - Running setup.py install for mozdebug 15:09:33 INFO - Running setup.py install for mozdevice 15:09:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Running setup.py install for mozfile 15:09:33 INFO - Running setup.py install for mozhttpd 15:09:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Running setup.py install for mozinfo 15:09:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Running setup.py install for mozInstall 15:09:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Running setup.py install for mozleak 15:09:33 INFO - Running setup.py install for mozlog 15:09:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Running setup.py install for moznetwork 15:09:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:09:33 INFO - Running setup.py install for mozprocess 15:09:34 INFO - Running setup.py install for mozprofile 15:09:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:09:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:09:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:09:34 INFO - Running setup.py install for mozrunner 15:09:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:09:34 INFO - Running setup.py install for mozscreenshot 15:09:34 INFO - Running setup.py install for moztest 15:09:34 INFO - Running setup.py install for mozversion 15:09:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:09:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:09:34 INFO - Cleaning up... 15:09:34 INFO - Return code: 0 15:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:09:34 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')]} 15:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:34 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')]} 15:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:34 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 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09:34 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 15:09:34 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 15:09:34 INFO - Using env: {'DISPLAY': ':0', 15:09:34 INFO - 'HOME': '/home/cltbld', 15:09:34 INFO - 'LANG': 'en_US.UTF-8', 15:09:34 INFO - 'LANGUAGE': 'en_US:en', 15:09:34 INFO - 'LOGNAME': 'cltbld', 15:09:34 INFO - 'MAIL': '/var/mail/cltbld', 15:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:34 INFO - 'MOZ_NO_REMOTE': '1', 15:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:34 INFO - 'NO_EM_RESTART': '1', 15:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:34 INFO - 'PWD': '/builds/slave/test', 15:09:34 INFO - 'SHELL': '/bin/bash', 15:09:34 INFO - 'SHLVL': '1', 15:09:34 INFO - 'TERM': 'linux', 15:09:34 INFO - 'TMOUT': '86400', 15:09:34 INFO - 'USER': 'cltbld', 15:09:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:34 INFO - '_': '/tools/buildbot/bin/python'} 15:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:09:34 INFO - Running setup.py (path:/tmp/pip-aWhogp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:09:34 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)) 15:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:09:34 INFO - Running setup.py (path:/tmp/pip-rdMqv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:09:35 INFO - Running setup.py (path:/tmp/pip-kHufyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:09:35 INFO - Running setup.py (path:/tmp/pip-Rho9ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:09:35 INFO - Running setup.py (path:/tmp/pip-bwPZza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:09:35 INFO - Running setup.py (path:/tmp/pip-s_1gnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:09:35 INFO - Running setup.py (path:/tmp/pip-G6QwSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:09:35 INFO - Running setup.py (path:/tmp/pip-4CaZPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:09:35 INFO - Running setup.py (path:/tmp/pip-5tanMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:09:35 INFO - Running setup.py (path:/tmp/pip-0wCSrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:09:35 INFO - Running setup.py (path:/tmp/pip-lsX0m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:09:35 INFO - Running setup.py (path:/tmp/pip-BUgAr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:09:35 INFO - Running setup.py (path:/tmp/pip-okyM_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:09:35 INFO - Running setup.py (path:/tmp/pip-VsVC9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:35 INFO - Running setup.py (path:/tmp/pip-JNyC1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:35 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)) 15:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:09:35 INFO - Running setup.py (path:/tmp/pip-xIofUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:09:36 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)) 15:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:09:36 INFO - Running setup.py (path:/tmp/pip-Uh3sSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:09:36 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)) 15:09:36 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)) 15:09:36 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)) 15:09:36 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)) 15:09:36 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)) 15:09:36 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)) 15:09:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:09:36 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 15:09:36 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 15:09:36 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 15:09:36 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 15:09:36 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 15:09:36 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 15:09:38 INFO - Downloading blessings-1.6.tar.gz 15:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:09:38 INFO - Installing collected packages: blessings 15:09:38 INFO - Running setup.py install for blessings 15:09:38 INFO - Successfully installed blessings 15:09:38 INFO - Cleaning up... 15:09:38 INFO - Return code: 0 15:09:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:09:38 INFO - Reading from file tmpfile_stdout 15:09:38 INFO - Current package versions: 15:09:38 INFO - argparse == 1.2.1 15:09:38 INFO - blessings == 1.6 15:09:38 INFO - blobuploader == 1.2.4 15:09:38 INFO - docopt == 0.6.1 15:09:38 INFO - functools32 == 3.2.3-2 15:09:38 INFO - jsonschema == 2.5.1 15:09:38 INFO - manifestparser == 1.1 15:09:38 INFO - mozInstall == 1.12 15:09:38 INFO - mozcrash == 1.0 15:09:38 INFO - mozdebug == 0.1 15:09:38 INFO - mozdevice == 0.48 15:09:38 INFO - mozfile == 1.2 15:09:38 INFO - mozhttpd == 0.7 15:09:38 INFO - mozinfo == 0.9 15:09:38 INFO - mozleak == 0.1 15:09:38 INFO - mozlog == 3.4 15:09:38 INFO - moznetwork == 0.27 15:09:38 INFO - mozprocess == 0.23 15:09:38 INFO - mozprofile == 0.28 15:09:38 INFO - mozrunner == 6.13 15:09:38 INFO - mozscreenshot == 0.1 15:09:38 INFO - mozsystemmonitor == 0.3 15:09:38 INFO - moztest == 0.7 15:09:38 INFO - mozversion == 1.4 15:09:38 INFO - psutil == 3.1.1 15:09:38 INFO - requests == 1.2.3 15:09:38 INFO - wsgiref == 0.1.2 15:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:09:38 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')]} 15:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:38 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')]} 15:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:38 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 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09:38 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 15:09:38 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 15:09:38 INFO - Using env: {'DISPLAY': ':0', 15:09:38 INFO - 'HOME': '/home/cltbld', 15:09:38 INFO - 'LANG': 'en_US.UTF-8', 15:09:38 INFO - 'LANGUAGE': 'en_US:en', 15:09:38 INFO - 'LOGNAME': 'cltbld', 15:09:38 INFO - 'MAIL': '/var/mail/cltbld', 15:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:38 INFO - 'MOZ_NO_REMOTE': '1', 15:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:38 INFO - 'NO_EM_RESTART': '1', 15:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:38 INFO - 'PWD': '/builds/slave/test', 15:09:38 INFO - 'SHELL': '/bin/bash', 15:09:38 INFO - 'SHLVL': '1', 15:09:38 INFO - 'TERM': 'linux', 15:09:38 INFO - 'TMOUT': '86400', 15:09:38 INFO - 'USER': 'cltbld', 15:09:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:38 INFO - '_': '/tools/buildbot/bin/python'} 15:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:38 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)) 15:09:38 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)) 15:09:38 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)) 15:09:38 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)) 15:09:38 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)) 15:09:38 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)) 15:09:38 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)) 15:09:38 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)) 15:09:38 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)) 15:09:38 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)) 15:09:38 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)) 15:09:38 INFO - Cleaning up... 15:09:38 INFO - Return code: 0 15:09:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:09:38 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')]} 15:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:38 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')]} 15:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:38 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 0x7f80137f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, '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': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', '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 15:09:38 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 15:09:38 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 15:09:38 INFO - Using env: {'DISPLAY': ':0', 15:09:38 INFO - 'HOME': '/home/cltbld', 15:09:38 INFO - 'LANG': 'en_US.UTF-8', 15:09:38 INFO - 'LANGUAGE': 'en_US:en', 15:09:38 INFO - 'LOGNAME': 'cltbld', 15:09:38 INFO - 'MAIL': '/var/mail/cltbld', 15:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:38 INFO - 'MOZ_NO_REMOTE': '1', 15:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:38 INFO - 'NO_EM_RESTART': '1', 15:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:38 INFO - 'PWD': '/builds/slave/test', 15:09:38 INFO - 'SHELL': '/bin/bash', 15:09:38 INFO - 'SHLVL': '1', 15:09:38 INFO - 'TERM': 'linux', 15:09:38 INFO - 'TMOUT': '86400', 15:09:38 INFO - 'USER': 'cltbld', 15:09:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:38 INFO - '_': '/tools/buildbot/bin/python'} 15:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:09:39 INFO - Cleaning up... 15:09:39 INFO - Return code: 0 15:09:39 INFO - Running post-action listener: _resource_record_post_action 15:09:39 INFO - Running post-action listener: _start_resource_monitoring 15:09:39 INFO - Starting resource monitoring. 15:09:39 INFO - [mozharness: 2016-11-25 23:09:39.068409Z] Finished create-virtualenv step (success) 15:09:39 INFO - [mozharness: 2016-11-25 23:09:39.068857Z] Running install step. 15:09:39 INFO - Running pre-action listener: _resource_record_pre_action 15:09:39 INFO - Running main action method: install 15:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:09:39 INFO - Reading from file tmpfile_stdout 15:09:39 INFO - Detecting whether we're running mozinstall >=1.0... 15:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:09:39 INFO - Reading from file tmpfile_stdout 15:09:39 INFO - Output received: 15:09:39 INFO - Usage: mozinstall [options] installer 15:09:39 INFO - Options: 15:09:39 INFO - -h, --help show this help message and exit 15:09:39 INFO - -d DEST, --destination=DEST 15:09:39 INFO - Directory to install application into. [default: 15:09:39 INFO - "/builds/slave/test"] 15:09:39 INFO - --app=APP Application being installed. [default: firefox] 15:09:39 INFO - mkdir: /builds/slave/test/build/application 15:09:39 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'] 15:09:39 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 15:09:55 INFO - Reading from file tmpfile_stdout 15:09:55 INFO - Output received: 15:09:55 INFO - /builds/slave/test/build/application/firefox/firefox 15:09:55 INFO - Running post-action listener: _resource_record_post_action 15:09:55 INFO - [mozharness: 2016-11-25 23:09:55.485129Z] Finished install step (success) 15:09:55 INFO - [mozharness: 2016-11-25 23:09:55.485370Z] Running run-tests step. 15:09:55 INFO - Running pre-action listener: _resource_record_pre_action 15:09:55 INFO - Running main action method: run_tests 15:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:09:55 INFO - Python 2.7.3 15:09:55 INFO - Return code: 0 15:09:55 INFO - grabbing minidump binary from tooltool 15:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:55 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 0x22def60>, '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 0x22dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:09:55 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 15:09:55 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 15:09:55 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 15:09:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:09:55 INFO - Return code: 0 15:09:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:09:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:09:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:09:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:09:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:09:55 INFO - Using env: {'DISPLAY': ':0', 15:09:55 INFO - 'HOME': '/home/cltbld', 15:09:55 INFO - 'LANG': 'en_US.UTF-8', 15:09:55 INFO - 'LANGUAGE': 'en_US:en', 15:09:55 INFO - 'LOGNAME': 'cltbld', 15:09:55 INFO - 'MAIL': '/var/mail/cltbld', 15:09:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:09:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:55 INFO - 'MOZ_NO_REMOTE': '1', 15:09:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:55 INFO - 'NO_EM_RESTART': '1', 15:09:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:55 INFO - 'PWD': '/builds/slave/test', 15:09:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:09:55 INFO - 'SHELL': '/bin/bash', 15:09:55 INFO - 'SHLVL': '1', 15:09:55 INFO - 'TERM': 'linux', 15:09:55 INFO - 'TMOUT': '86400', 15:09:55 INFO - 'USER': 'cltbld', 15:09:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957', 15:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:55 INFO - '_': '/tools/buildbot/bin/python'} 15:09:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:09:55 INFO - mozversion application_buildid: 20161125122519 15:09:55 INFO - mozversion application_changeset: bafd3cf3970490e029351e6befa56667f568f85f 15:09:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:09:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:09:55 INFO - mozversion application_name: Firefox 15:09:55 INFO - mozversion application_remotingname: firefox-dev 15:09:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:09:55 INFO - mozversion application_vendor: Mozilla 15:09:55 INFO - mozversion application_version: 52.0a2 15:09:55 INFO - mozversion platform_buildid: 20161125122519 15:09:55 INFO - mozversion platform_changeset: bafd3cf3970490e029351e6befa56667f568f85f 15:09:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:09:55 INFO - mozversion platform_version: 52.0a2 15:09:55 INFO - using testdate: 1480115395 15:09:55 INFO - actual date: 1480115395 15:09:55 INFO - starting webserver on 'localhost:55892' 15:09:55 INFO - SUITE-START | Running 2 tests 15:09:55 INFO - TEST-START | dromaeo_css 15:09:55 INFO - operating with platform_type : linux_ 15:09:55 INFO - Initialising browser for dromaeo_css test... 15:09:55 INFO - TEST-INFO | started process 11521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG1s2_k/profile http://localhost:55892/getInfo.html) 15:09:59 INFO - PROCESS | 11521 | __metrics Screen width/height:1600/1200 15:09:59 INFO - PROCESS | 11521 | colorDepth:24 15:09:59 INFO - PROCESS | 11521 | Browser inner width/height: 1024/697 15:09:59 INFO - PROCESS | 11521 | __metrics 15:10:00 INFO - PROCESS | 11521 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:10:00 INFO - PROCESS | 11521 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:10:00 INFO - PROCESS | 11521 | console.error: PushService: 15:10:00 INFO - PROCESS | 11521 | stateChangeProcessEnqueue: Error transitioning state 15:10:00 INFO - PROCESS | 11521 | UnknownError 15:10:01 INFO - TEST-INFO | 11521: exit 0 15:10:01 INFO - Browser initialized. 15:10:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:10:01 INFO - TEST-INFO | started process 11612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG1s2_k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:13 INFO - PROCESS | 11612 | RSS: Main: 144699392 15:10:13 INFO - PROCESS | 11612 | 15:11:05 INFO - PROCESS | 11612 | 1480115465010 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] 15:13:15 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55892/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55892/tests/dromaeo/cssquery-ext.html) 15:13:16 INFO - PROCESS | 11612 | RSS: Main: 317186048 15:13:16 INFO - PROCESS | 11612 | 15:16:19 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55892/tests/dromaeo/cssquery-ext.html (next: http://localhost:55892/tests/dromaeo/cssquery-jquery.html) 15:16:19 INFO - PROCESS | 11612 | RSS: Main: 231985152 15:16:19 INFO - PROCESS | 11612 | 15:19:21 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55892/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55892/tests/dromaeo/cssquery-mootools.html) 15:19:22 INFO - PROCESS | 11612 | RSS: Main: 176082944 15:19:22 INFO - PROCESS | 11612 | 15:22:24 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55892/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55892/tests/dromaeo/cssquery-prototype.html) 15:22:25 INFO - PROCESS | 11612 | RSS: Main: 214323200 15:22:25 INFO - PROCESS | 11612 | 15:25:27 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55892/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55892/tests/dromaeo/cssquery-yui.html) 15:25:28 INFO - PROCESS | 11612 | RSS: Main: 175046656 15:25:28 INFO - PROCESS | 11612 | 15:28:31 INFO - PROCESS | 11612 | Cycle 1(1): loaded http://localhost:55892/tests/dromaeo/cssquery-yui.html (next: http://localhost:55892/tests/dromaeo/cssquery-dojo.html) 15:28:31 INFO - PROCESS | 11612 | RSS: Main: 264601600 15:28:31 INFO - PROCESS | 11612 | 15:28:31 INFO - PROCESS | 11612 | __start_tp_report 15:28:31 INFO - PROCESS | 11612 | _x_x_mozilla_page_load 15:28:31 INFO - PROCESS | 11612 | _x_x_mozilla_page_load_details 15:28:31 INFO - PROCESS | 11612 | |i|pagename|runs| 15:28:31 INFO - PROCESS | 11612 | |0;dojo.html;3237.3039796443763;3255.267564797922;3266.216108134047;3273.3126043530856;3298.9340213195737;5563.777448902044;5658.236138121352;5660;5661.745221465034;5672.8581785455335;5599.7480113394895;5710.514606258473;5720.570957178207;5721.399253078429;5753.309602847654;5134.6405751597495;5163.845084647448;5171.22431635254;5191.506806853362;5233.345831771028;5036.521530454601;5061.620378471611;5257.947420525803;5261.394939581959;5294.073537131006;5123.436421993578;5142.922856157161;5147.536721695046;5156.793728250866;5161.225816127592;5185.403678576974;5203.037438073969;5270.130428479296;5277.3139491866195;5301.787928482856;5002.324686167357;5089.465606111379;5172.5344718975475;5230.398504172031;5235.921461178085;5541.944580554183;5543.944560554383;5549.250851135126;5579.079451890433;5623.128415095667;6033.728482218266;6034.6982650867285;6117.5717699761035;6134.846628834271;6136.815895523141;5929.407059294036;6172.722227499773;6178.84552886177;6191.504679625619;6193.256809182927;5582.385937546866;5652.152177173416;5698.629589076697;5711.200431939532;5725.599208055396;6271.341509141565;6272.1219029335925;6272.466840318532;6285.937140628535;6287.088372186007;5765.85585360361;6012.518998480111;6020.127081573148;6024.518038556905;6033.547483938634;5873.706314684248;6032.487238584769;6087.086936959491;6090.116933044772;6155.815325540241;6110.557768924303;6120.213136796047;6120.242537778152;6121.28888135384;6121.767890854219;5836.153757705109;6069.666168360694;6097.993831017921;6104.3590423005835;6106.572539922252;4588.95411045892;4602.079584083197;4635.466921304093;4640.350350950869;4642.907141857144;4142.834286628561;4174.2069006889205;4186.162767446462;4192.874213773592;4201.852935147316;5754.108113242454;5772.3938986406665;5784.4504772046585;5784.82645520635;5792.739326730307;5937.614055086406;6012.068129439944;6047.667378294236;6052.697365131726;6148.1085242639565;5776.653400795965;5785.652860828363;5786.71066446676;5820.738066787005;5843.444872737083;5225.085610018232;5235.685858848481;5237.371515418175;5237.580993520585;5245.449227831099;6135.018317212141;6151.292601350902;6172.135900973957;6306.716197771111;6383.2978372379;6055.969720151371;6136.059583474799;6136.73353236607;6136.948001697639;6140.473573783631;6335.588186767845;6341.587796793194;6341.8097457076365;6345.206849143857;6347.079673447417;5758.798442054508;5844.035734103995;5988.161657367885;5995.580309378476;5997.310309314485;5998.310194327533;6029.306629737636;6051.546134039877;6094.847628809315;6124.29570599369;5919.7040147991565;5957.463828255478;5961.642301461926;5969.164316995537;5982.551308651781;5670.092785154356;5905.527557795452;5909;5937.317208520903;5945.613535120204;5783.971080144741;5822.126680997884;5863.237779088691;5864.794732184524;5866.5893387464175;5905.232319798399;5927.377625349276;5944.8811023780145;5993.280806303272;6011.60924539921;5667.603267771216;5729.570282228933;5730.684812335361;5898.734556944862;5916.911246331395 15:28:31 INFO - PROCESS | 11612 | |1;ext.html;538.0465439187723;596.4721221718779;610.529891983173;646.4698946863571;658.7167517967272;29032.709672903264;43306.56693433065;43454.99999999996;43629.56370436295;43746;44124.77937610308;44745.55254447454;44799;44799.32801007987;44845.551544484624;8288.917110828876;8846.601902914384;8987.146221109017;8992.46045237288;8992.730218093435;8352.958235208815;10564.78870422595;10807.621733239339;10818.404987725671;11104.222704410655;10540.156787456985;10584.100351470135;10586.20603454744;10589.629362972297;10592.894071059267;10695.251332406695;10787.406692631863;10788.892111078867;10789.46052697362;10790.73023174427;10672.09287210588;10684.145268378512;10738.463076846127;10755.731106722316;10759.569617215302;41968.79015604902;42329.365059524134;42368.152636947394;42377.36433953493;42453.36319955203;2941.4558306713325;2990.9700902990908;3108.922276943072;3126.390353880994;3192.8403579820915;31753.84123079393;32205.677943220504;32300;32458.6754132458;32603.83698081518;4060.8578699745367;4374.715643483195;4381.07997320563;4400.515943246241;4432.667549933768;396210;397799;399539.0023049895;400621;402896;37187.25625487475;62208.68895655493;62651.686741566;62876.68561657254;62916.370836291055;37587.812060940065;40152.39771403431;40189.59810401917;40272.395914061315;40411.1917761649;15044.849551504563;15049.699006020037;15052.397904083933;15064.849351506564;15065.472708455152;11335.149863760085;11663.775303593171;11948.581799637144;12259.570915017932;12342.568010119603;9172.8624070639;9279.489628070385;9331.486768227676;9388.389754665925;9426.245900327956;3444.483327500895;3469.150058235698;3499.61504234534;3507.9123021924147;3523.224890524081;903.3046640928875;1013.6756238003916;1058.0636137018794;1063.5107850388908;1127.334872425273;32529.51205731916;32918.67081329204;33019.504707429405;33116.83441582777;33162;1050.56926660069;1104.4588151805717;1119.4234968990813;1128.8927551882557;1149.3965668024186;16275.778806950811;16760.497185084467;17343.132843358035;17407.911050674;17413.216405261795;556435;557731;558321;561888;568974;59701.70149149226;59839.70080149572;59875.70062149662;59921.101183482286;60053.399466005656;1118.0440723181562;1226.2336039975016;1322.642886420661;1364.3314775759807;1364.6110858405307;29318.70681293245;32990.17524561905;33730.32539349249;34107.3376807768;34269;51093;51650.74174629103;51654.741726291126;51705.741471293906;51723.22415163851;416883.32466700993;418452;418820;419398;419566;29505.557416638338;29964.70035299619;30221.69778302189;30544;31903;47582.28626570535;47972.280415793095;48084.27873581829;48188.518114818406;48242.27636585524;40900.1819963605;40921;41018.79490602647;41323;42349.576504235796;41218;41880.1623967525;41990;42009.15981680288;43533;41614;41692.791536042125;41823.16353672848;41838.581614183466;42386.788066059475;35164;36864;36914.261714765016;37747.05632359103;38128.42807357836;27818.582721258794;28550.57174142348;28634.713652864037;28651.856740716164;28673.42653146967 15:28:31 INFO - PROCESS | 11612 | |2;jquery.html;388.3185010306911;390.8885967499263;408.7404498143679;416.633362640876;423.40722987817054;14238.715225695492;16233.26950287237;19350.419487415365;19690.11394487248;19970.40088797335;18903.52741181471;18968.241270349205;19127;19139.521511962208;19406.029698515053;5531.668099914018;5555.555555555546;5677.8580535486735;5791.623544469617;5800.1299805029375;4086.2031903778775;5630.268065151545;5745.195672605839;5745.425457454263;5751.252337196159;4217.367394890775;6055;6266.968665156668;6275.780347687832;6386.1697979262635;6071.635701857903;6186.474149697281;6243.968780156093;6249.375062493759;6320.399562041599;5536.889262214773;5541.0580201365865;5541.5289700375515;5543.057680194376;5544.695041772701;22487.21294754692;23243.302700919;23796.167134150222;23816.64275035876;24033.279001629806;2328.4411741181993;2596.649452323931;2610.3865591585964;2642.1941307901084;2922.0503336415536;14851.77722334155;15297.61755956099;15568.299426525833;15714.978526395747;15755.133467659274;1932.9710054349196;2004.7494063242095;2084.2600876688707;2089.2374283386453;2125.033109934976;53407;92167.07832921651;92877;97223;98455.50772246164;16911.91544042272;17726.822731772776;17836;18110.818891811177;18797.906010470135;32304.19239518984;32365.19087022843;32424.513632295533;32449.513257301158;32551.837240813646;9666.371685840399;9819.656312029045;9946.552405141785;10039.4478303694;10182.64360747385;8059.274665280153;8282;8320.8335833283;8379.874301885477;8512.40413171072;8782.429142105742;8883.889513810773;8965;8975.910240897638;9063.36556441056;3192.2976945072046;3309.1396236978558;3365.2596428785628;3571.142925697866;3591.2458383739186;913.7304495173939;937.4890684576922;996.3324572536418;1009.5759780892043;1020.285799940045;18137.183826727563;19159.233630654897;19287.51781205481;19357.225710971685;19665.606687866162;956.5934477847027;979.1970584120952;1029.5881647341123;1032.4579595712162;1041.6874937518714;10168.28821982454;10725.195610329256;10846.94576527128;10883.619073332553;10952.890471095187;517129;529310;536122;537547;540707;91980;92410.53794730983;94959.0504094964;97964;98287;972.0571046085286;986.3292960786733;996.0437979539578;1010.4493051287067;1015.4871789746131;16452.83547164513;16515.344602736328;16579.751303730212;16986.320547177973;17597.12014399249;43970.99999999872;44073.55926440823;44330.77834610806;44573.77713111414;45879;58517.70741146267;58898;59523.70238148781;60549.39450605614;62165.378346215955;8494.57527123629;8777.605007774539;8791.076936921787;8913.153250441197;9115.498647574446;9809.950950245204;13018.152464758816;13579.253141077335;13782.93108534451;13841;11284.266522676;11564.47959841826;11645.5341786331;11883.524659013543;11947.163698541019;11384.260023098472;11535.76928461443;11683.123765717435;11787.11596630239;12174.269543827399;6539.476841852736;8888.377813553248;11359.204855660024;12045.277283363026;12208.633740987785;7772.92227077722;8833.726597458719;8848.955755221183;8948;9009.369344145847;11153.330800152016;11178.441077946232;11274.887251127384;11420.885791142315;11549.6535103947 15:28:31 INFO - PROCESS | 11612 | |3;mootools.html;1323.9404226809793;1459.2120255062266;1493.9402423903043;1607.2526275281998;1748.5628592851788;7664.578448185348;8484.95757521213;8716.694915677952;8729.214370706643;8985.23625491834;8735.694250701226;8807.2513836324;8808.955955220232;8811.295096392289;8816.955915220431;2450.399652085237;2484.7018357797087;2485.801135909123;2486.577281862079;2487.017628036924;2373.821963352747;2440.1825388494785;2493.0775613023206;2493.925182244536;2495.6007038873786;2457.8525288482747;2460.4709987352717;2494.762997515233;2495.301315631626;2496.151308555091;2395.9760402396014;2406.57884870147;2442.206282958028;2448.7428819974;2453.141400509825;2402.1952645863657;2438.7073551173794;2449.8407603505893;2462.2859370782453;2463.408781892333;8994.190522852974;9150.954245228731;9215.677451289173;9220.031896650822;9228.723138305862;5537.446255374431;5859.941400585983;5861.0915308127305;5863.472287494146;5868.970655146697;3503.2818272254126;3599.8380072896784;3642.5446819147605;3682.6317368263226;3725.0873535983587;1234.3519652182677;1243.247835059794;1257.6981524434161;1292.7479141567399;1294.249335385474;12763.234205947672;12888.226706397552;12907.741845163044;12918.22490650564;13004.959603231624;4682.212544484436;4742.407199100113;4795.448523419782;4850.151223535867;4872.4640289568115;9910.20718342531;9919.454430006419;9931.80136397268;9934.652287170058;9939.503024848873;5622.522085622768;5627.352854421712;5628.240187574707;5632.7746890123935;5633.239512665819;4473.977630111829;4606.170889239902;4758.714477131314;5147.56245719118;5255.106631872591;3904.219156168721;3956.8219430125714;4041.8585349512628;4059.3707975263883;4064.878053658395;1186.7211205366732;1250.6810763255494;1252.7369252457086;1255.2719422734792;1260.5840072775961;815.2051749544147;851.642310229705;857.8155696525278;887.1306120002305;893.071205945822;5768.74040668171;5904.940950590439;5942.58401911862;6021.6989150542295;6076.240469941257;464.3568657409512;464.3684588959013;466.126013724267;469.0267694533788;473.6447664251811;4016.8393264269685;4028.657564107025;4035.1122752994293;4053.8783836484954;4104.589541045932;11445.198836081394;11735.706607334885;11789;11839.467223974942;11917.821232681517;11653.59212427561;11657.950784429442;11711.297322160697;11743.88256117428;11748.588799392151;8176.528224919452;8526.232639062515;8533.104024077382;8675.783105422415;8714.564271786512;5835.124731290341;5881.2942446906645;6007.068904319837;6032.215811944419;6114.908276375769;10578.418186999788;10631.362118272928;10652.520636571218;10698.090662293793;10714.51784669676;9519.857202141835;9748.025197480196;10111.3427627204;10576.629817956335;10585.153187744809;7379.151397589131;7539.811504712206;7541.962290188733;7697.769066928001;7857.9214207857185;8612.870806937775;8621;8707.390482666153;8717.564121793757;8719.040905500264;7860.5676687782725;7874.56689882062;7943.4042446815565;7953.16491768356;8022.679092836222;7661.923380766121;7691.192424795316;7736.883946740691;7907.604619768874;7908.4464087513325;7316.707331706672;7449.329560339595;7453.329200371993;7455.850882982419;7457.030586024;5118;5217.34783152106;5237.476252374884;5258.50044245796;5404.32445944257;5198.740062996911;5236.947630523646;5267.73661316925;5315.574754019592;5428.728563571726 15:28:31 INFO - PROCESS | 11612 | |4;prototype.html;340.81936573615974;341.6259196180183;353.68522015406285;357.9695725863302;359.6493418916557;5403.567714582834;5416.864578385543;5442.265294185284;5458.590605704569;5458.836234912954;5112.974435127829;5203.375594928614;5247.553957913582;5306.973465132679;5378.579639162373;4202.306619407802;4205.7897105144775;4212.936805947913;4214.789260536961;4230.090530535934;4220.831166753342;4261.147770445908;4262.46719160105;4283.828646854137;4306.655467562588;3988.8603898863544;4003.677866837242;4226.1547690461875;4226.3026600610865;4255.489341279051;4195.790210489494;4218.620324170809;4220.831166753326;4228.238916994939;4275.209086319025;3760.379537376357;3768.2651882882847;3778.1298257362505;3783.1677031053123;3785.716071294664;5070.619703522214;5212.322398088262;5225.2162175673575;5236.423993360727;5270.314859068297;4742.834000809989;4836.661433699643;4839.588634966032;4846.903061938777;4849.903001939977;5571.609987300891;5574.665520068768;5580.553555715533;5581.386047534768;5664.433556644302;3917.882463526099;4071.7556946583004;4103.671706263522;4196.244675958326;4200.768957707325;5791.855203619901;5828.388019258002;5832.270966129234;5833.008388573952;5836.299644042742;4211.347241177622;4217.219814334358;4226.387173859773;4235.343521754072;4251.893702657397;4193.22425351311;4223.7539925721985;4257.914841703148;4288.871333859989;4300.397944287803;4821.108095002365;4836.758162091881;4838.661293709407;4850.199717046718;4858.222684370484;5633.408492108351;5674.290713660793;5678.744456499468;5692.430756924275;5717.628354156966;1360.952066908475;1411.4495346814545;1412.7850048957887;1413.250976982201;1429.7712366021387;925.6393102139843;931.5388882503204;956.153803883568;984.5667906121283;985.4481490365275;5316.441773613792;5320.419596495696;5340.172273297645;5343.893122137535;5359.159645387951;5578.9163162552595;5595.992721310203;5599.852030333772;5605.523530499953;5612.719364031864;5248.317718696545;5304.469553044664;5314.441983591667;5336.866578335573;5344.198370244417;2951.5867778511024;2961.8074825136296;2965.836878971634;2969.806962547471;2981.6720160782297;5552.6668399895325;5695.145728140812;5773.942260577341;5779.682117483579;5835.095560188178;5596.38439771633;5663.338231031491;5666.801661941895;5667.6316039458125;5674.177244299553;5702.914456283076;5724.62247274102;5728.856778580569;5742.052116938467;5748.14874034398;5331.054165229586;5484.369297530676;5532.557395408277;5546.694931778791;5557.471350535416;5463.350275116644;5480.479354461319;5496.532794712494;5500.3949565548555;5524.364698059774;5454.727263636723;5750.9424905752085;5758;5763;5773.566982476247;4048.9190216196102;4051.2505186540584;4060.9187816244103;4069.270560012042;4083.387491876242;5562.833115006556;5586.86032849182;5647.858803529944;5648.971755141198;5670.291213598301;5322.973385133049;5486.231927530069;5545.584081194007;5563.833085007456;5566.304211973504;5343.9198412024625;5364.275822763877;5385.946140538545;5427.864303392446;5449.1826226066405;5322.361316642027;5392.730363481732;5410.729463526729;5416.647917885325;5520.1443776214755;5471.85091130867;5678.3186017678145;5679.233303504139;5696.20253164549;5701.458361455655;5483.945160548344;5542.501174894279;5576.330840299028;5595.223224323647;5600.943990560205 15:28:31 INFO - PROCESS | 11612 | |5;yui.html;699.7107729617447;742.0909386002148;748.6705849426252;798.5568009754584;817.2154731457798;14552.345144468498;15365.692686146298;15394.384224631016;15582.298796554154;15598.766018509717;13501.324933753322;13609.183448993068;13620.046596738208;13623.727525449485;13625.931870340635;668.8361351468873;685.9348361905611;755.2108047090776;770.9845803083934;772.8956590860232;774.5275382016965;778.9532628042307;779.1040303650818;779.6686408276488;779.8791187365968;822.5311572403732;822.7737372222626;823.0206054794805;823.7199352220244;824.0770337222319;700.6251655364381;718.0987860235372;719.7229066809316;720.3732752505354;821.2649678537705;581.2066529187671;595.6574969392573;596.0254983102615;597.4085655201319;600.2197143713155;14023.298835058205;14026.579202623938;14078.92960535201;14104;14247.28763561828;13495.527656531975;13786.172829630254;13971.58085257444;14000.159990400507;14067.577972660836;11998.640040798702;12028.939855300756;12160.331181784999;12283.754324913541;12430.564930227489;3747.2505498900055;3804.752691075071;3860.20865722529;4225.809838557272;4276.657867370634;63898.36101639017;64165.67917160431;64495.67752161303;65011.67494162546;65215;10917.563297468012;10938.507767150497;10945.890541094646;11029.558817647205;11191.552337906556;17801.7329740054;18311.450656480327;18319.81680183208;18873.905630472036;19091.236350545823;8123.75628731139;8133.471324364015;8214.424990250625;8362.540060296742;8625.353098517637;4515.503294637587;4620.7227566345455;4638.930416043762;4736.407949006374;4791.496892826272;3702.22253326799;3807.428885667172;3810.333191691443;3828.3300422425964;3835.1179228777537;656.5469825820169;664.3091185167372;672.9327067293232;685.0785693242581;691.011853050133;568.8606291458619;693.6011793218819;723.7249845058844;728.1298847876736;740.1229542991572;8642.030832271468;8794.296456283482;8979.236764874928;9330.95334523323;9552.95223523878;519.9324087868553;535.5795700375264;564.7091747749912;604.7580967612902;640.5132099604241;4170.52039015511;4277.893052673708;4331.6318112960125;4400.251957167289;4460.955390446119;94410.52794735982;94919.52540237254;95072.52463737637;96004;96690;50381.49618503841;62592.68703656544;82378;82732.58633706793;84891;48236.34700091529;48348.51651483511;63281.68359158175;72936;73362.8995565067;8130.390220733587;8284;8313;8313.875291870505;8404.337146118058;43492.56507434885;50849.74575127101;51368.22947655863;51737.48262517327;52042.73978630234;60951.69524152351;63116.36883631105;63272.683636581525;63816.36183638104;64799.67600162158;11913.404329783649;12039.157258992136;12167.330796805907;12168.87831121713;12703.682407939876;13792.793108103588;14068.859311406755;14224;14323.498677546237;15271.236438178268;12501.499940002299;12660.493580256687;13052.54316098932;13982.58052258434;14321.283935803376;13639.79540306916;13683.315834208448;13791.724165516433;14000.299985000913;14157.858421415654;13103.541376051793;13430.261335626634;13460.125091868997;13784.724305514033;13979.231142287272;11195;11468.770624587294;11575.189736718348;12066.638000859988;12080;11331.660050198177;11633.95294423506;11763.235389699643;11875.109366797353;12121.090918180995 15:28:31 INFO - PROCESS | 11612 | __end_tp_report 15:28:31 INFO - PROCESS | 11612 | __start_cc_report 15:28:31 INFO - PROCESS | 11612 | _x_x_mozilla_cycle_collect,1795 15:28:31 INFO - PROCESS | 11612 | __end_cc_report 15:28:31 INFO - PROCESS | 11612 | __startTimestamp1480116511263__endTimestamp 15:28:31 INFO - PROCESS | 11612 | 15:28:31 INFO - PROCESS | 11612 | ------- Summary: start ------- 15:28:31 INFO - PROCESS | 11612 | Number of tests: 6 15:28:31 INFO - PROCESS | 11612 | 15:28:31 INFO - PROCESS | 11612 | [#0] dojo.html Cycles:165 Average:5641.85 Median:5836.15 stddev:642.46 (11.0%) stddev-sans-first:616.12 15:28:31 INFO - PROCESS | 11612 | Values: 3237.3 3255.3 3266.2 3273.3 3298.9 5563.8 5658.2 5660.0 5661.7 5672.9 5599.7 5710.5 5720.6 5721.4 5753.3 5134.6 5163.8 5171.2 5191.5 5233.3 5036.5 5061.6 5257.9 5261.4 5294.1 5123.4 5142.9 5147.5 5156.8 5161.2 5185.4 5203.0 5270.1 5277.3 5301.8 5002.3 5089.5 5172.5 5230.4 5235.9 5541.9 5543.9 5549.3 5579.1 5623.1 6033.7 6034.7 6117.6 6134.8 6136.8 5929.4 6172.7 6178.8 6191.5 6193.3 5582.4 5652.2 5698.6 5711.2 5725.6 6271.3 6272.1 6272.5 6285.9 6287.1 5765.9 6012.5 6020.1 6024.5 6033.5 5873.7 6032.5 6087.1 6090.1 6155.8 6110.6 6120.2 6120.2 6121.3 6121.8 5836.2 6069.7 6098.0 6104.4 6106.6 4589.0 4602.1 4635.5 4640.4 4642.9 4142.8 4174.2 4186.2 4192.9 4201.9 5754.1 5772.4 5784.5 5784.8 5792.7 5937.6 6012.1 6047.7 6052.7 6148.1 5776.7 5785.7 5786.7 5820.7 5843.4 5225.1 5235.7 5237.4 5237.6 5245.4 6135.0 6151.3 6172.1 6306.7 6383.3 6056.0 6136.1 6136.7 6136.9 6140.5 6335.6 6341.6 6341.8 6345.2 6347.1 5758.8 5844.0 5988.2 5995.6 5997.3 5998.3 6029.3 6051.5 6094.8 6124.3 5919.7 5957.5 5961.6 5969.2 5982.6 5670.1 5905.5 5909.0 5937.3 5945.6 5784.0 5822.1 5863.2 5864.8 5866.6 5905.2 5927.4 5944.9 5993.3 6011.6 5667.6 5729.6 5730.7 5898.7 5916.9 15:28:31 INFO - PROCESS | 11612 | 15:28:31 INFO - PROCESS | 11612 | [#1] ext.html Cycles:180 Average:61160.45 Median:217169.21 stddev:123539.27 (56.9%) stddev-sans-first:123801.98 15:28:31 INFO - PROCESS | 11612 | Values: 538.0 596.5 610.5 646.5 658.7 29032.7 43306.6 43455.0 43629.6 43746.0 44124.8 44745.6 44799.0 44799.3 44845.6 8288.9 8846.6 8987.1 8992.5 8992.7 8353.0 10564.8 10807.6 10818.4 11104.2 10540.2 10584.1 10586.2 10589.6 10592.9 10695.3 10787.4 10788.9 10789.5 10790.7 10672.1 10684.1 10738.5 10755.7 10759.6 41968.8 42329.4 42368.2 42377.4 42453.4 2941.5 2991.0 3108.9 3126.4 3192.8 31753.8 32205.7 32300.0 32458.7 32603.8 4060.9 4374.7 4381.1 4400.5 4432.7 396210.0 397799.0 399539.0 400621.0 402896.0 37187.3 62208.7 62651.7 62876.7 62916.4 37587.8 40152.4 40189.6 40272.4 40411.2 15044.8 15049.7 15052.4 15064.8 15065.5 11335.1 11663.8 11948.6 12259.6 12342.6 9172.9 9279.5 9331.5 9388.4 9426.2 3444.5 3469.2 3499.6 3507.9 3523.2 903.3 1013.7 1058.1 1063.5 1127.3 32529.5 32918.7 33019.5 33116.8 33162.0 1050.6 1104.5 1119.4 1128.9 1149.4 16275.8 16760.5 17343.1 17407.9 17413.2 556435.0 557731.0 558321.0 561888.0 568974.0 59701.7 59839.7 59875.7 59921.1 60053.4 1118.0 1226.2 1322.6 1364.3 1364.6 29318.7 32990.2 33730.3 34107.3 34269.0 51093.0 51650.7 51654.7 51705.7 51723.2 416883.3 418452.0 418820.0 419398.0 419566.0 29505.6 29964.7 30221.7 30544.0 31903.0 47582.3 47972.3 48084.3 48188.5 48242.3 40900.2 40921.0 41018.8 41323.0 42349.6 41218.0 41880.2 41990.0 42009.2 43533.0 41614.0 41692.8 41823.2 41838.6 42386.8 35164.0 36864.0 36914.3 37747.1 38128.4 27818.6 28550.6 28634.7 28651.9 28673.4 15:28:31 INFO - PROCESS | 11612 | 15:28:31 INFO - PROCESS | 11612 | [#2] jquery.html Cycles:180 Average:31499.57 Median:1989.78 stddev:87627.23 (4403.9%) stddev-sans-first:87841.91 15:28:31 INFO - PROCESS | 11612 | Values: 388.3 390.9 408.7 416.6 423.4 14238.7 16233.3 19350.4 19690.1 19970.4 18903.5 18968.2 19127.0 19139.5 19406.0 5531.7 5555.6 5677.9 5791.6 5800.1 4086.2 5630.3 5745.2 5745.4 5751.3 4217.4 6055.0 6267.0 6275.8 6386.2 6071.6 6186.5 6244.0 6249.4 6320.4 5536.9 5541.1 5541.5 5543.1 5544.7 22487.2 23243.3 23796.2 23816.6 24033.3 2328.4 2596.6 2610.4 2642.2 2922.1 14851.8 15297.6 15568.3 15715.0 15755.1 1933.0 2004.7 2084.3 2089.2 2125.0 53407.0 92167.1 92877.0 97223.0 98455.5 16911.9 17726.8 17836.0 18110.8 18797.9 32304.2 32365.2 32424.5 32449.5 32551.8 9666.4 9819.7 9946.6 10039.4 10182.6 8059.3 8282.0 8320.8 8379.9 8512.4 8782.4 8883.9 8965.0 8975.9 9063.4 3192.3 3309.1 3365.3 3571.1 3591.2 913.7 937.5 996.3 1009.6 1020.3 18137.2 19159.2 19287.5 19357.2 19665.6 956.6 979.2 1029.6 1032.5 1041.7 10168.3 10725.2 10846.9 10883.6 10952.9 517129.0 529310.0 536122.0 537547.0 540707.0 91980.0 92410.5 94959.1 97964.0 98287.0 972.1 986.3 996.0 1010.4 1015.5 16452.8 16515.3 16579.8 16986.3 17597.1 43971.0 44073.6 44330.8 44573.8 45879.0 58517.7 58898.0 59523.7 60549.4 62165.4 8494.6 8777.6 8791.1 8913.2 9115.5 9810.0 13018.2 13579.3 13782.9 13841.0 11284.3 11564.5 11645.5 11883.5 11947.2 11384.3 11535.8 11683.1 11787.1 12174.3 6539.5 8888.4 11359.2 12045.3 12208.6 7772.9 8833.7 8849.0 8948.0 9009.4 11153.3 11178.4 11274.9 11420.9 11549.7 15:28:31 INFO - PROCESS | 11612 | 15:28:31 INFO - PROCESS | 11612 | [#3] mootools.html Cycles:180 Average:5952.94 Median:4995.23 stddev:3421.71 (68.5%) stddev-sans-first:3413.63 15:28:31 INFO - PROCESS | 11612 | Values: 1323.9 1459.2 1493.9 1607.3 1748.6 7664.6 8485.0 8716.7 8729.2 8985.2 8735.7 8807.3 8809.0 8811.3 8817.0 2450.4 2484.7 2485.8 2486.6 2487.0 2373.8 2440.2 2493.1 2493.9 2495.6 2457.9 2460.5 2494.8 2495.3 2496.2 2396.0 2406.6 2442.2 2448.7 2453.1 2402.2 2438.7 2449.8 2462.3 2463.4 8994.2 9151.0 9215.7 9220.0 9228.7 5537.4 5859.9 5861.1 5863.5 5869.0 3503.3 3599.8 3642.5 3682.6 3725.1 1234.4 1243.2 1257.7 1292.7 1294.2 12763.2 12888.2 12907.7 12918.2 13005.0 4682.2 4742.4 4795.4 4850.2 4872.5 9910.2 9919.5 9931.8 9934.7 9939.5 5622.5 5627.4 5628.2 5632.8 5633.2 4474.0 4606.2 4758.7 5147.6 5255.1 3904.2 3956.8 4041.9 4059.4 4064.9 1186.7 1250.7 1252.7 1255.3 1260.6 815.2 851.6 857.8 887.1 893.1 5768.7 5904.9 5942.6 6021.7 6076.2 464.4 464.4 466.1 469.0 473.6 4016.8 4028.7 4035.1 4053.9 4104.6 11445.2 11735.7 11789.0 11839.5 11917.8 11653.6 11658.0 11711.3 11743.9 11748.6 8176.5 8526.2 8533.1 8675.8 8714.6 5835.1 5881.3 6007.1 6032.2 6114.9 10578.4 10631.4 10652.5 10698.1 10714.5 9519.9 9748.0 10111.3 10576.6 10585.2 7379.2 7539.8 7542.0 7697.8 7857.9 8612.9 8621.0 8707.4 8717.6 8719.0 7860.6 7874.6 7943.4 7953.2 8022.7 7661.9 7691.2 7736.9 7907.6 7908.4 7316.7 7449.3 7453.3 7455.9 7457.0 5118.0 5217.3 5237.5 5258.5 5404.3 5198.7 5236.9 5267.7 5315.6 5428.7 15:28:31 INFO - PROCESS | 11612 | 15:28:31 INFO - PROCESS | 11612 | [#4] prototype.html Cycles:180 Average:4687.95 Median:5344.06 stddev:1347.71 (25.2%) stddev-sans-first:1311.40 15:28:31 INFO - PROCESS | 11612 | Values: 340.8 341.6 353.7 358.0 359.6 5403.6 5416.9 5442.3 5458.6 5458.8 5113.0 5203.4 5247.6 5307.0 5378.6 4202.3 4205.8 4212.9 4214.8 4230.1 4220.8 4261.1 4262.5 4283.8 4306.7 3988.9 4003.7 4226.2 4226.3 4255.5 4195.8 4218.6 4220.8 4228.2 4275.2 3760.4 3768.3 3778.1 3783.2 3785.7 5070.6 5212.3 5225.2 5236.4 5270.3 4742.8 4836.7 4839.6 4846.9 4849.9 5571.6 5574.7 5580.6 5581.4 5664.4 3917.9 4071.8 4103.7 4196.2 4200.8 5791.9 5828.4 5832.3 5833.0 5836.3 4211.3 4217.2 4226.4 4235.3 4251.9 4193.2 4223.8 4257.9 4288.9 4300.4 4821.1 4836.8 4838.7 4850.2 4858.2 5633.4 5674.3 5678.7 5692.4 5717.6 1361.0 1411.4 1412.8 1413.3 1429.8 925.6 931.5 956.2 984.6 985.4 5316.4 5320.4 5340.2 5343.9 5359.2 5578.9 5596.0 5599.9 5605.5 5612.7 5248.3 5304.5 5314.4 5336.9 5344.2 2951.6 2961.8 2965.8 2969.8 2981.7 5552.7 5695.1 5773.9 5779.7 5835.1 5596.4 5663.3 5666.8 5667.6 5674.2 5702.9 5724.6 5728.9 5742.1 5748.1 5331.1 5484.4 5532.6 5546.7 5557.5 5463.4 5480.5 5496.5 5500.4 5524.4 5454.7 5750.9 5758.0 5763.0 5773.6 4048.9 4051.3 4060.9 4069.3 4083.4 5562.8 5586.9 5647.9 5649.0 5670.3 5323.0 5486.2 5545.6 5563.8 5566.3 5343.9 5364.3 5385.9 5427.9 5449.2 5322.4 5392.7 5410.7 5416.6 5520.1 5471.9 5678.3 5679.2 5696.2 5701.5 5483.9 5542.5 5576.3 5595.2 5600.9 15:28:31 INFO - PROCESS | 11612 | 15:28:31 INFO - PROCESS | 11612 | [#5] yui.html Cycles:180 Average:17912.55 Median:26513.92 stddev:23899.78 (90.1%) stddev-sans-first:23931.88 15:28:31 INFO - PROCESS | 11612 | Values: 699.7 742.1 748.7 798.6 817.2 14552.3 15365.7 15394.4 15582.3 15598.8 13501.3 13609.2 13620.0 13623.7 13625.9 668.8 685.9 755.2 771.0 772.9 774.5 779.0 779.1 779.7 779.9 822.5 822.8 823.0 823.7 824.1 700.6 718.1 719.7 720.4 821.3 581.2 595.7 596.0 597.4 600.2 14023.3 14026.6 14078.9 14104.0 14247.3 13495.5 13786.2 13971.6 14000.2 14067.6 11998.6 12028.9 12160.3 12283.8 12430.6 3747.3 3804.8 3860.2 4225.8 4276.7 63898.4 64165.7 64495.7 65011.7 65215.0 10917.6 10938.5 10945.9 11029.6 11191.6 17801.7 18311.5 18319.8 18873.9 19091.2 8123.8 8133.5 8214.4 8362.5 8625.4 4515.5 4620.7 4638.9 4736.4 4791.5 3702.2 3807.4 3810.3 3828.3 3835.1 656.5 664.3 672.9 685.1 691.0 568.9 693.6 723.7 728.1 740.1 8642.0 8794.3 8979.2 9331.0 9553.0 519.9 535.6 564.7 604.8 640.5 4170.5 4277.9 4331.6 4400.3 4461.0 94410.5 94919.5 95072.5 96004.0 96690.0 50381.5 62592.7 82378.0 82732.6 84891.0 48236.3 48348.5 63281.7 72936.0 73362.9 8130.4 8284.0 8313.0 8313.9 8404.3 43492.6 50849.7 51368.2 51737.5 52042.7 60951.7 63116.4 63272.7 63816.4 64799.7 11913.4 12039.2 12167.3 12168.9 12703.7 13792.8 14068.9 14224.0 14323.5 15271.2 12501.5 12660.5 13052.5 13982.6 14321.3 13639.8 13683.3 13791.7 14000.3 14157.9 13103.5 13430.3 13460.1 13784.7 13979.2 11195.0 11468.8 11575.2 12066.6 12080.0 11331.7 11634.0 11763.2 11875.1 12121.1 15:28:31 INFO - PROCESS | 11612 | -------- Summary: end -------- 15:28:31 INFO - PROCESS | 11612 | 15:28:31 INFO - TEST-INFO | 11612: exit 0 15:28:31 INFO - TEST-OK | dromaeo_css | took 1116188ms 15:28:31 INFO - TEST-START | kraken 15:28:31 INFO - operating with platform_type : linux_ 15:28:31 INFO - Initialising browser for kraken test... 15:28:31 INFO - TEST-INFO | started process 11929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO1QIfz/profile http://localhost:55892/getInfo.html) 15:28:35 INFO - PROCESS | 11929 | __metrics Screen width/height:1600/1200 15:28:35 INFO - PROCESS | 11929 | colorDepth:24 15:28:35 INFO - PROCESS | 11929 | Browser inner width/height: 1024/697 15:28:35 INFO - PROCESS | 11929 | __metrics 15:28:36 INFO - PROCESS | 11929 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:28:36 INFO - PROCESS | 11929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:28:36 INFO - PROCESS | 11929 | console.error: PushService: 15:28:36 INFO - PROCESS | 11929 | stateChangeProcessEnqueue: Error transitioning state 15:28:36 INFO - PROCESS | 11929 | UnknownError 15:28:37 INFO - TEST-INFO | 11929: exit 0 15:28:37 INFO - Browser initialized. 15:28:37 INFO - Running cycle 1/1 for kraken test... 15:28:37 INFO - TEST-INFO | started process 12024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO1QIfz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:28:49 INFO - PROCESS | 12024 | RSS: Main: 144465920 15:28:49 INFO - PROCESS | 12024 | 15:28:51 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55892/tests/kraken/driver.html?testName=audio-beat-detection) 15:28:52 INFO - PROCESS | 12024 | RSS: Main: 185823232 15:28:52 INFO - PROCESS | 12024 | 15:28:55 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55892/tests/kraken/driver.html?testName=audio-dft) 15:28:55 INFO - PROCESS | 12024 | RSS: Main: 175038464 15:28:55 INFO - PROCESS | 12024 | 15:28:58 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55892/tests/kraken/driver.html?testName=audio-fft) 15:28:59 INFO - PROCESS | 12024 | RSS: Main: 266588160 15:28:59 INFO - PROCESS | 12024 | 15:29:01 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55892/tests/kraken/driver.html?testName=audio-oscillator) 15:29:01 INFO - PROCESS | 12024 | RSS: Main: 172855296 15:29:01 INFO - PROCESS | 12024 | 15:29:04 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55892/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:29:04 INFO - PROCESS | 12024 | RSS: Main: 175796224 15:29:04 INFO - PROCESS | 12024 | 15:29:07 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55892/tests/kraken/driver.html?testName=imaging-darkroom) 15:29:08 INFO - PROCESS | 12024 | RSS: Main: 213823488 15:29:08 INFO - PROCESS | 12024 | 15:29:11 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55892/tests/kraken/driver.html?testName=imaging-desaturate) 15:29:12 INFO - PROCESS | 12024 | RSS: Main: 213147648 15:29:12 INFO - PROCESS | 12024 | 15:29:14 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55892/tests/kraken/driver.html?testName=json-parse-financial) 15:29:15 INFO - PROCESS | 12024 | RSS: Main: 211791872 15:29:15 INFO - PROCESS | 12024 | 15:29:16 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55892/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:29:17 INFO - PROCESS | 12024 | RSS: Main: 173674496 15:29:17 INFO - PROCESS | 12024 | 15:29:19 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55892/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:29:19 INFO - PROCESS | 12024 | RSS: Main: 180170752 15:29:19 INFO - PROCESS | 12024 | 15:29:21 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55892/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:29:22 INFO - PROCESS | 12024 | RSS: Main: 190218240 15:29:22 INFO - PROCESS | 12024 | 15:29:24 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:29:25 INFO - PROCESS | 12024 | RSS: Main: 199913472 15:29:25 INFO - PROCESS | 12024 | 15:29:28 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:29:28 INFO - PROCESS | 12024 | RSS: Main: 195641344 15:29:28 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | Cycle 1(1): loaded http://localhost:55892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55892/tests/kraken/driver.html?testName=ai-astar) 15:29:30 INFO - PROCESS | 12024 | RSS: Main: 247160832 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | __start_tp_report 15:29:30 INFO - PROCESS | 12024 | _x_x_mozilla_page_load 15:29:30 INFO - PROCESS | 12024 | _x_x_mozilla_page_load_details 15:29:30 INFO - PROCESS | 12024 | |i|pagename|runs| 15:29:30 INFO - PROCESS | 12024 | |0;ai-astar;102;110;112;110;111;110;110;111;110;110 15:29:30 INFO - PROCESS | 12024 | |1;audio-beat-detection;154;123;123;164;132;127;121;120;151;124 15:29:30 INFO - PROCESS | 12024 | |2;audio-dft;160;161;161;158;158;159;160;159;164;159 15:29:30 INFO - PROCESS | 12024 | |3;audio-fft;75;75;74;112;76;83;84;75;99;76 15:29:30 INFO - PROCESS | 12024 | |4;audio-oscillator;82;81;112;81;82;81;98;82;81;115 15:29:30 INFO - PROCESS | 12024 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 15:29:30 INFO - PROCESS | 12024 | |6;imaging-darkroom;147;147;147;146;146;146;146;146;146;145 15:29:30 INFO - PROCESS | 12024 | |7;imaging-desaturate;84;84;85;85;86;85;85;85;85;85 15:29:30 INFO - PROCESS | 12024 | |8;json-parse-financial;50;49;49;49;49;49;49;49;49;51 15:29:30 INFO - PROCESS | 12024 | |9;json-stringify-tinderbox;57;59;58;60;59;59;59;58;58;59 15:29:30 INFO - PROCESS | 12024 | |10;stanford-crypto-aes;75;76;80;75;85;77;76;78;75;75 15:29:30 INFO - PROCESS | 12024 | |11;stanford-crypto-ccm;132;139;125;137;125;128;129;139;161;152 15:29:30 INFO - PROCESS | 12024 | |12;stanford-crypto-pbkdf2;159;153;153;152;155;152;156;156;156;154 15:29:30 INFO - PROCESS | 12024 | |13;stanford-crypto-sha256-iterative;66;62;62;63;64;66;61;61;65;61 15:29:30 INFO - PROCESS | 12024 | __end_tp_report 15:29:30 INFO - PROCESS | 12024 | __start_cc_report 15:29:30 INFO - PROCESS | 12024 | _x_x_mozilla_cycle_collect,1611 15:29:30 INFO - PROCESS | 12024 | __end_cc_report 15:29:30 INFO - PROCESS | 12024 | __startTimestamp1480116570719__endTimestamp 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | ------- Summary: start ------- 15:29:30 INFO - PROCESS | 12024 | Number of tests: 14 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.76 (2.5%) stddev-sans-first:0.73 15:29:30 INFO - PROCESS | 12024 | Values: 102.0 110.0 112.0 110.0 111.0 110.0 110.0 111.0 110.0 110.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:129.50 stddev:16.16 (12.5%) stddev-sans-first:15.41 15:29:30 INFO - PROCESS | 12024 | Values: 154.0 123.0 123.0 164.0 132.0 127.0 121.0 120.0 151.0 124.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.79 (1.1%) stddev-sans-first:1.90 15:29:30 INFO - PROCESS | 12024 | Values: 160.0 161.0 161.0 158.0 158.0 159.0 160.0 159.0 164.0 159.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:12.78 (16.8%) stddev-sans-first:13.23 15:29:30 INFO - PROCESS | 12024 | Values: 75.0 75.0 74.0 112.0 76.0 83.0 84.0 75.0 99.0 76.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:81.50 stddev:13.69 (16.8%) stddev-sans-first:14.25 15:29:30 INFO - PROCESS | 12024 | Values: 82.0 81.0 112.0 81.0 82.0 81.0 98.0 82.0 81.0 115.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:29:30 INFO - PROCESS | 12024 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 15:29:30 INFO - PROCESS | 12024 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 15:29:30 INFO - PROCESS | 12024 | Values: 84.0 84.0 85.0 85.0 86.0 85.0 85.0 85.0 85.0 85.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.00 stddev:0.67 (1.4%) stddev-sans-first:0.67 15:29:30 INFO - PROCESS | 12024 | Values: 50.0 49.0 49.0 49.0 49.0 49.0 49.0 49.0 49.0 51.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.84 (1.4%) stddev-sans-first:0.67 15:29:30 INFO - PROCESS | 12024 | Values: 57.0 59.0 58.0 60.0 59.0 59.0 59.0 58.0 58.0 59.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.50 stddev:3.19 (4.2%) stddev-sans-first:3.28 15:29:30 INFO - PROCESS | 12024 | Values: 75.0 76.0 80.0 75.0 85.0 77.0 76.0 78.0 75.0 75.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:138.00 stddev:11.86 (8.6%) stddev-sans-first:12.46 15:29:30 INFO - PROCESS | 12024 | Values: 132.0 139.0 125.0 137.0 125.0 128.0 129.0 139.0 161.0 152.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.50 stddev:2.22 (1.4%) stddev-sans-first:1.69 15:29:30 INFO - PROCESS | 12024 | Values: 159.0 153.0 153.0 152.0 155.0 152.0 156.0 156.0 156.0 154.0 15:29:30 INFO - PROCESS | 12024 | 15:29:30 INFO - PROCESS | 12024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:2.02 (3.2%) stddev-sans-first:1.86 15:29:30 INFO - PROCESS | 12024 | Values: 66.0 62.0 62.0 63.0 64.0 66.0 61.0 61.0 65.0 61.0 15:29:30 INFO - PROCESS | 12024 | -------- Summary: end -------- 15:29:30 INFO - PROCESS | 12024 | 15:29:31 INFO - TEST-INFO | 12024: exit 0 15:29:32 INFO - TEST-OK | kraken | took 60080ms 15:29:32 INFO - SUITE-END | took 1176s 15:29:32 INFO - Completed test suite (00:19:36) 15:29:32 INFO - javascript benchmark 15:29:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3237.3039796443763, 3255.267564797922, 3266.216108134047, 3273.3126043530856, 3298.9340213195737, 5563.777448902044, 5658.236138121352, 5660.0, 5661.745221465034, 5672.8581785455335, 5599.7480113394895, 5710.514606258473, 5720.570957178207, 5721.399253078429, 5753.309602847654, 5134.6405751597495, 5163.845084647448, 5171.22431635254, 5191.506806853362, 5233.345831771028, 5036.521530454601, 5061.620378471611, 5257.947420525803, 5261.394939581959, 5294.073537131006, 5123.436421993578, 5142.922856157161, 5147.536721695046, 5156.793728250866, 5161.225816127592, 5185.403678576974, 5203.037438073969, 5270.130428479296, 5277.3139491866195, 5301.787928482856, 5002.324686167357, 5089.465606111379, 5172.5344718975475, 5230.398504172031, 5235.921461178085, 5541.944580554183, 5543.944560554383, 5549.250851135126, 5579.079451890433, 5623.128415095667, 6033.728482218266, 6034.6982650867285, 6117.5717699761035, 6134.846628834271, 6136.815895523141, 5929.407059294036, 6172.722227499773, 6178.84552886177, 6191.504679625619, 6193.256809182927, 5582.385937546866, 5652.152177173416, 5698.629589076697, 5711.200431939532, 5725.599208055396, 6271.341509141565, 6272.1219029335925, 6272.466840318532, 6285.937140628535, 6287.088372186007, 5765.85585360361, 6012.518998480111, 6020.127081573148, 6024.518038556905, 6033.547483938634, 5873.706314684248, 6032.487238584769, 6087.086936959491, 6090.116933044772, 6155.815325540241, 6110.557768924303, 6120.213136796047, 6120.242537778152, 6121.28888135384, 6121.767890854219, 5836.153757705109, 6069.666168360694, 6097.993831017921, 6104.3590423005835, 6106.572539922252, 4588.95411045892, 4602.079584083197, 4635.466921304093, 4640.350350950869, 4642.907141857144, 4142.834286628561, 4174.2069006889205, 4186.162767446462, 4192.874213773592, 4201.852935147316, 5754.108113242454, 5772.3938986406665, 5784.4504772046585, 5784.82645520635, 5792.739326730307, 5937.614055086406, 6012.068129439944, 6047.667378294236, 6052.697365131726, 6148.1085242639565, 5776.653400795965, 5785.652860828363, 5786.71066446676, 5820.738066787005, 5843.444872737083, 5225.085610018232, 5235.685858848481, 5237.371515418175, 5237.580993520585, 5245.449227831099, 6135.018317212141, 6151.292601350902, 6172.135900973957, 6306.716197771111, 6383.2978372379, 6055.969720151371, 6136.059583474799, 6136.73353236607, 6136.948001697639, 6140.473573783631, 6335.588186767845, 6341.587796793194, 6341.8097457076365, 6345.206849143857, 6347.079673447417, 5758.798442054508, 5844.035734103995, 5988.161657367885, 5995.580309378476, 5997.310309314485, 5998.310194327533, 6029.306629737636, 6051.546134039877, 6094.847628809315, 6124.29570599369, 5919.7040147991565, 5957.463828255478, 5961.642301461926, 5969.164316995537, 5982.551308651781, 5670.092785154356, 5905.527557795452, 5909.0, 5937.317208520903, 5945.613535120204, 5783.971080144741, 5822.126680997884, 5863.237779088691, 5864.794732184524, 5866.5893387464175, 5905.232319798399, 5927.377625349276, 5944.8811023780145, 5993.280806303272, 6011.60924539921, 5667.603267771216, 5729.570282228933, 5730.684812335361, 5898.734556944862, 5916.911246331395], "value": 5598.382526915311, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.0465439187723, 596.4721221718779, 610.529891983173, 646.4698946863571, 658.7167517967272, 29032.709672903264, 43306.56693433065, 43454.99999999996, 43629.56370436295, 43746.0, 44124.77937610308, 44745.55254447454, 44799.0, 44799.32801007987, 44845.551544484624, 8288.917110828876, 8846.601902914384, 8987.146221109017, 8992.46045237288, 8992.730218093435, 8352.958235208815, 10564.78870422595, 10807.621733239339, 10818.404987725671, 11104.222704410655, 10540.156787456985, 10584.100351470135, 10586.20603454744, 10589.629362972297, 10592.894071059267, 10695.251332406695, 10787.406692631863, 10788.892111078867, 10789.46052697362, 10790.73023174427, 10672.09287210588, 10684.145268378512, 10738.463076846127, 10755.731106722316, 10759.569617215302, 41968.79015604902, 42329.365059524134, 42368.152636947394, 42377.36433953493, 42453.36319955203, 2941.4558306713325, 2990.9700902990908, 3108.922276943072, 3126.390353880994, 3192.8403579820915, 31753.84123079393, 32205.677943220504, 32300.0, 32458.6754132458, 32603.83698081518, 4060.8578699745367, 4374.715643483195, 4381.07997320563, 4400.515943246241, 4432.667549933768, 396210.0, 397799.0, 399539.0023049895, 400621.0, 402896.0, 37187.25625487475, 62208.68895655493, 62651.686741566, 62876.68561657254, 62916.370836291055, 37587.812060940065, 40152.39771403431, 40189.59810401917, 40272.395914061315, 40411.1917761649, 15044.849551504563, 15049.699006020037, 15052.397904083933, 15064.849351506564, 15065.472708455152, 11335.149863760085, 11663.775303593171, 11948.581799637144, 12259.570915017932, 12342.568010119603, 9172.8624070639, 9279.489628070385, 9331.486768227676, 9388.389754665925, 9426.245900327956, 3444.483327500895, 3469.150058235698, 3499.61504234534, 3507.9123021924147, 3523.224890524081, 903.3046640928875, 1013.6756238003916, 1058.0636137018794, 1063.5107850388908, 1127.334872425273, 32529.51205731916, 32918.67081329204, 33019.504707429405, 33116.83441582777, 33162.0, 1050.56926660069, 1104.4588151805717, 1119.4234968990813, 1128.8927551882557, 1149.3965668024186, 16275.778806950811, 16760.497185084467, 17343.132843358035, 17407.911050674, 17413.216405261795, 556435.0, 557731.0, 558321.0, 561888.0, 568974.0, 59701.70149149226, 59839.70080149572, 59875.70062149662, 59921.101183482286, 60053.399466005656, 1118.0440723181562, 1226.2336039975016, 1322.642886420661, 1364.3314775759807, 1364.6110858405307, 29318.70681293245, 32990.17524561905, 33730.32539349249, 34107.3376807768, 34269.0, 51093.0, 51650.74174629103, 51654.741726291126, 51705.741471293906, 51723.22415163851, 416883.32466700993, 418452.0, 418820.0, 419398.0, 419566.0, 29505.557416638338, 29964.70035299619, 30221.69778302189, 30544.0, 31903.0, 47582.28626570535, 47972.280415793095, 48084.27873581829, 48188.518114818406, 48242.27636585524, 40900.1819963605, 40921.0, 41018.79490602647, 41323.0, 42349.576504235796, 41218.0, 41880.1623967525, 41990.0, 42009.15981680288, 43533.0, 41614.0, 41692.791536042125, 41823.16353672848, 41838.581614183466, 42386.788066059475, 35164.0, 36864.0, 36914.261714765016, 37747.05632359103, 38128.42807357836, 27818.582721258794, 28550.57174142348, 28634.713652864037, 28651.856740716164, 28673.42653146967], "value": 19473.904934061942, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.3185010306911, 390.8885967499263, 408.7404498143679, 416.633362640876, 423.40722987817054, 14238.715225695492, 16233.26950287237, 19350.419487415365, 19690.11394487248, 19970.40088797335, 18903.52741181471, 18968.241270349205, 19127.0, 19139.521511962208, 19406.029698515053, 5531.668099914018, 5555.555555555546, 5677.8580535486735, 5791.623544469617, 5800.1299805029375, 4086.2031903778775, 5630.268065151545, 5745.195672605839, 5745.425457454263, 5751.252337196159, 4217.367394890775, 6055.0, 6266.968665156668, 6275.780347687832, 6386.1697979262635, 6071.635701857903, 6186.474149697281, 6243.968780156093, 6249.375062493759, 6320.399562041599, 5536.889262214773, 5541.0580201365865, 5541.5289700375515, 5543.057680194376, 5544.695041772701, 22487.21294754692, 23243.302700919, 23796.167134150222, 23816.64275035876, 24033.279001629806, 2328.4411741181993, 2596.649452323931, 2610.3865591585964, 2642.1941307901084, 2922.0503336415536, 14851.77722334155, 15297.61755956099, 15568.299426525833, 15714.978526395747, 15755.133467659274, 1932.9710054349196, 2004.7494063242095, 2084.2600876688707, 2089.2374283386453, 2125.033109934976, 53407.0, 92167.07832921651, 92877.0, 97223.0, 98455.50772246164, 16911.91544042272, 17726.822731772776, 17836.0, 18110.818891811177, 18797.906010470135, 32304.19239518984, 32365.19087022843, 32424.513632295533, 32449.513257301158, 32551.837240813646, 9666.371685840399, 9819.656312029045, 9946.552405141785, 10039.4478303694, 10182.64360747385, 8059.274665280153, 8282.0, 8320.8335833283, 8379.874301885477, 8512.40413171072, 8782.429142105742, 8883.889513810773, 8965.0, 8975.910240897638, 9063.36556441056, 3192.2976945072046, 3309.1396236978558, 3365.2596428785628, 3571.142925697866, 3591.2458383739186, 913.7304495173939, 937.4890684576922, 996.3324572536418, 1009.5759780892043, 1020.285799940045, 18137.183826727563, 19159.233630654897, 19287.51781205481, 19357.225710971685, 19665.606687866162, 956.5934477847027, 979.1970584120952, 1029.5881647341123, 1032.4579595712162, 1041.6874937518714, 10168.28821982454, 10725.195610329256, 10846.94576527128, 10883.619073332553, 10952.890471095187, 517129.0, 529310.0, 536122.0, 537547.0, 540707.0, 91980.0, 92410.53794730983, 94959.0504094964, 97964.0, 98287.0, 972.0571046085286, 986.3292960786733, 996.0437979539578, 1010.4493051287067, 1015.4871789746131, 16452.83547164513, 16515.344602736328, 16579.751303730212, 16986.320547177973, 17597.12014399249, 43970.99999999872, 44073.55926440823, 44330.77834610806, 44573.77713111414, 45879.0, 58517.70741146267, 58898.0, 59523.70238148781, 60549.39450605614, 62165.378346215955, 8494.57527123629, 8777.605007774539, 8791.076936921787, 8913.153250441197, 9115.498647574446, 9809.950950245204, 13018.152464758816, 13579.253141077335, 13782.93108534451, 13841.0, 11284.266522676, 11564.47959841826, 11645.5341786331, 11883.524659013543, 11947.163698541019, 11384.260023098472, 11535.76928461443, 11683.123765717435, 11787.11596630239, 12174.269543827399, 6539.476841852736, 8888.377813553248, 11359.204855660024, 12045.277283363026, 12208.633740987785, 7772.92227077722, 8833.726597458719, 8848.955755221183, 8948.0, 9009.369344145847, 11153.330800152016, 11178.441077946232, 11274.887251127384, 11420.885791142315, 11549.6535103947], "value": 10111.076761380282, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.9404226809793, 1459.2120255062266, 1493.9402423903043, 1607.2526275281998, 1748.5628592851788, 7664.578448185348, 8484.95757521213, 8716.694915677952, 8729.214370706643, 8985.23625491834, 8735.694250701226, 8807.2513836324, 8808.955955220232, 8811.295096392289, 8816.955915220431, 2450.399652085237, 2484.7018357797087, 2485.801135909123, 2486.577281862079, 2487.017628036924, 2373.821963352747, 2440.1825388494785, 2493.0775613023206, 2493.925182244536, 2495.6007038873786, 2457.8525288482747, 2460.4709987352717, 2494.762997515233, 2495.301315631626, 2496.151308555091, 2395.9760402396014, 2406.57884870147, 2442.206282958028, 2448.7428819974, 2453.141400509825, 2402.1952645863657, 2438.7073551173794, 2449.8407603505893, 2462.2859370782453, 2463.408781892333, 8994.190522852974, 9150.954245228731, 9215.677451289173, 9220.031896650822, 9228.723138305862, 5537.446255374431, 5859.941400585983, 5861.0915308127305, 5863.472287494146, 5868.970655146697, 3503.2818272254126, 3599.8380072896784, 3642.5446819147605, 3682.6317368263226, 3725.0873535983587, 1234.3519652182677, 1243.247835059794, 1257.6981524434161, 1292.7479141567399, 1294.249335385474, 12763.234205947672, 12888.226706397552, 12907.741845163044, 12918.22490650564, 13004.959603231624, 4682.212544484436, 4742.407199100113, 4795.448523419782, 4850.151223535867, 4872.4640289568115, 9910.20718342531, 9919.454430006419, 9931.80136397268, 9934.652287170058, 9939.503024848873, 5622.522085622768, 5627.352854421712, 5628.240187574707, 5632.7746890123935, 5633.239512665819, 4473.977630111829, 4606.170889239902, 4758.714477131314, 5147.56245719118, 5255.106631872591, 3904.219156168721, 3956.8219430125714, 4041.8585349512628, 4059.3707975263883, 4064.878053658395, 1186.7211205366732, 1250.6810763255494, 1252.7369252457086, 1255.2719422734792, 1260.5840072775961, 815.2051749544147, 851.642310229705, 857.8155696525278, 887.1306120002305, 893.071205945822, 5768.74040668171, 5904.940950590439, 5942.58401911862, 6021.6989150542295, 6076.240469941257, 464.3568657409512, 464.3684588959013, 466.126013724267, 469.0267694533788, 473.6447664251811, 4016.8393264269685, 4028.657564107025, 4035.1122752994293, 4053.8783836484954, 4104.589541045932, 11445.198836081394, 11735.706607334885, 11789.0, 11839.467223974942, 11917.821232681517, 11653.59212427561, 11657.950784429442, 11711.297322160697, 11743.88256117428, 11748.588799392151, 8176.528224919452, 8526.232639062515, 8533.104024077382, 8675.783105422415, 8714.564271786512, 5835.124731290341, 5881.2942446906645, 6007.068904319837, 6032.215811944419, 6114.908276375769, 10578.418186999788, 10631.362118272928, 10652.520636571218, 10698.090662293793, 10714.51784669676, 9519.857202141835, 9748.025197480196, 10111.3427627204, 10576.629817956335, 10585.153187744809, 7379.151397589131, 7539.811504712206, 7541.962290188733, 7697.769066928001, 7857.9214207857185, 8612.870806937775, 8621.0, 8707.390482666153, 8717.564121793757, 8719.040905500264, 7860.5676687782725, 7874.56689882062, 7943.4042446815565, 7953.16491768356, 8022.679092836222, 7661.923380766121, 7691.192424795316, 7736.883946740691, 7907.604619768874, 7908.4464087513325, 7316.707331706672, 7449.329560339595, 7453.329200371993, 7455.850882982419, 7457.030586024, 5118.0, 5217.34783152106, 5237.476252374884, 5258.50044245796, 5404.32445944257, 5198.740062996911, 5236.947630523646, 5267.73661316925, 5315.574754019592, 5428.728563571726], "value": 4673.5701396468685, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.81936573615974, 341.6259196180183, 353.68522015406285, 357.9695725863302, 359.6493418916557, 5403.567714582834, 5416.864578385543, 5442.265294185284, 5458.590605704569, 5458.836234912954, 5112.974435127829, 5203.375594928614, 5247.553957913582, 5306.973465132679, 5378.579639162373, 4202.306619407802, 4205.7897105144775, 4212.936805947913, 4214.789260536961, 4230.090530535934, 4220.831166753342, 4261.147770445908, 4262.46719160105, 4283.828646854137, 4306.655467562588, 3988.8603898863544, 4003.677866837242, 4226.1547690461875, 4226.3026600610865, 4255.489341279051, 4195.790210489494, 4218.620324170809, 4220.831166753326, 4228.238916994939, 4275.209086319025, 3760.379537376357, 3768.2651882882847, 3778.1298257362505, 3783.1677031053123, 3785.716071294664, 5070.619703522214, 5212.322398088262, 5225.2162175673575, 5236.423993360727, 5270.314859068297, 4742.834000809989, 4836.661433699643, 4839.588634966032, 4846.903061938777, 4849.903001939977, 5571.609987300891, 5574.665520068768, 5580.553555715533, 5581.386047534768, 5664.433556644302, 3917.882463526099, 4071.7556946583004, 4103.671706263522, 4196.244675958326, 4200.768957707325, 5791.855203619901, 5828.388019258002, 5832.270966129234, 5833.008388573952, 5836.299644042742, 4211.347241177622, 4217.219814334358, 4226.387173859773, 4235.343521754072, 4251.893702657397, 4193.22425351311, 4223.7539925721985, 4257.914841703148, 4288.871333859989, 4300.397944287803, 4821.108095002365, 4836.758162091881, 4838.661293709407, 4850.199717046718, 4858.222684370484, 5633.408492108351, 5674.290713660793, 5678.744456499468, 5692.430756924275, 5717.628354156966, 1360.952066908475, 1411.4495346814545, 1412.7850048957887, 1413.250976982201, 1429.7712366021387, 925.6393102139843, 931.5388882503204, 956.153803883568, 984.5667906121283, 985.4481490365275, 5316.441773613792, 5320.419596495696, 5340.172273297645, 5343.893122137535, 5359.159645387951, 5578.9163162552595, 5595.992721310203, 5599.852030333772, 5605.523530499953, 5612.719364031864, 5248.317718696545, 5304.469553044664, 5314.441983591667, 5336.866578335573, 5344.198370244417, 2951.5867778511024, 2961.8074825136296, 2965.836878971634, 2969.806962547471, 2981.6720160782297, 5552.6668399895325, 5695.145728140812, 5773.942260577341, 5779.682117483579, 5835.095560188178, 5596.38439771633, 5663.338231031491, 5666.801661941895, 5667.6316039458125, 5674.177244299553, 5702.914456283076, 5724.62247274102, 5728.856778580569, 5742.052116938467, 5748.14874034398, 5331.054165229586, 5484.369297530676, 5532.557395408277, 5546.694931778791, 5557.471350535416, 5463.350275116644, 5480.479354461319, 5496.532794712494, 5500.3949565548555, 5524.364698059774, 5454.727263636723, 5750.9424905752085, 5758.0, 5763.0, 5773.566982476247, 4048.9190216196102, 4051.2505186540584, 4060.9187816244103, 4069.270560012042, 4083.387491876242, 5562.833115006556, 5586.86032849182, 5647.858803529944, 5648.971755141198, 5670.291213598301, 5322.973385133049, 5486.231927530069, 5545.584081194007, 5563.833085007456, 5566.304211973504, 5343.9198412024625, 5364.275822763877, 5385.946140538545, 5427.864303392446, 5449.1826226066405, 5322.361316642027, 5392.730363481732, 5410.729463526729, 5416.647917885325, 5520.1443776214755, 5471.85091130867, 5678.3186017678145, 5679.233303504139, 5696.20253164549, 5701.458361455655, 5483.945160548344, 5542.501174894279, 5576.330840299028, 5595.223224323647, 5600.943990560205], "value": 4260.784053105377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.7107729617447, 742.0909386002148, 748.6705849426252, 798.5568009754584, 817.2154731457798, 14552.345144468498, 15365.692686146298, 15394.384224631016, 15582.298796554154, 15598.766018509717, 13501.324933753322, 13609.183448993068, 13620.046596738208, 13623.727525449485, 13625.931870340635, 668.8361351468873, 685.9348361905611, 755.2108047090776, 770.9845803083934, 772.8956590860232, 774.5275382016965, 778.9532628042307, 779.1040303650818, 779.6686408276488, 779.8791187365968, 822.5311572403732, 822.7737372222626, 823.0206054794805, 823.7199352220244, 824.0770337222319, 700.6251655364381, 718.0987860235372, 719.7229066809316, 720.3732752505354, 821.2649678537705, 581.2066529187671, 595.6574969392573, 596.0254983102615, 597.4085655201319, 600.2197143713155, 14023.298835058205, 14026.579202623938, 14078.92960535201, 14104.0, 14247.28763561828, 13495.527656531975, 13786.172829630254, 13971.58085257444, 14000.159990400507, 14067.577972660836, 11998.640040798702, 12028.939855300756, 12160.331181784999, 12283.754324913541, 12430.564930227489, 3747.2505498900055, 3804.752691075071, 3860.20865722529, 4225.809838557272, 4276.657867370634, 63898.36101639017, 64165.67917160431, 64495.67752161303, 65011.67494162546, 65215.0, 10917.563297468012, 10938.507767150497, 10945.890541094646, 11029.558817647205, 11191.552337906556, 17801.7329740054, 18311.450656480327, 18319.81680183208, 18873.905630472036, 19091.236350545823, 8123.75628731139, 8133.471324364015, 8214.424990250625, 8362.540060296742, 8625.353098517637, 4515.503294637587, 4620.7227566345455, 4638.930416043762, 4736.407949006374, 4791.496892826272, 3702.22253326799, 3807.428885667172, 3810.333191691443, 3828.3300422425964, 3835.1179228777537, 656.5469825820169, 664.3091185167372, 672.9327067293232, 685.0785693242581, 691.011853050133, 568.8606291458619, 693.6011793218819, 723.7249845058844, 728.1298847876736, 740.1229542991572, 8642.030832271468, 8794.296456283482, 8979.236764874928, 9330.95334523323, 9552.95223523878, 519.9324087868553, 535.5795700375264, 564.7091747749912, 604.7580967612902, 640.5132099604241, 4170.52039015511, 4277.893052673708, 4331.6318112960125, 4400.251957167289, 4460.955390446119, 94410.52794735982, 94919.52540237254, 95072.52463737637, 96004.0, 96690.0, 50381.49618503841, 62592.68703656544, 82378.0, 82732.58633706793, 84891.0, 48236.34700091529, 48348.51651483511, 63281.68359158175, 72936.0, 73362.8995565067, 8130.390220733587, 8284.0, 8313.0, 8313.875291870505, 8404.337146118058, 43492.56507434885, 50849.74575127101, 51368.22947655863, 51737.48262517327, 52042.73978630234, 60951.69524152351, 63116.36883631105, 63272.683636581525, 63816.36183638104, 64799.67600162158, 11913.404329783649, 12039.157258992136, 12167.330796805907, 12168.87831121713, 12703.682407939876, 13792.793108103588, 14068.859311406755, 14224.0, 14323.498677546237, 15271.236438178268, 12501.499940002299, 12660.493580256687, 13052.54316098932, 13982.58052258434, 14321.283935803376, 13639.79540306916, 13683.315834208448, 13791.724165516433, 14000.299985000913, 14157.858421415654, 13103.541376051793, 13430.261335626634, 13460.125091868997, 13784.724305514033, 13979.231142287272, 11195.0, 11468.770624587294, 11575.189736718348, 12066.638000859988, 12080.0, 11331.660050198177, 11633.95294423506, 11763.235389699643, 11875.109366797353, 12121.090918180995], "value": 7088.008764065166, "unit": "score"}], "name": "dromaeo_css", "value": 7333.926155507734, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 112.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 123.0, 164.0, 132.0, 127.0, 121.0, 120.0, 151.0, 124.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 158.0, 158.0, 159.0, 160.0, 159.0, 164.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 112.0, 76.0, 83.0, 84.0, 75.0, 99.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 112.0, 81.0, 82.0, 81.0, 98.0, 82.0, 81.0, 115.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 49.0, 49.0, 49.0, 49.0, 49.0, 49.0, 51.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 60.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 80.0, 75.0, 85.0, 77.0, 76.0, 78.0, 75.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 139.0, 125.0, 137.0, 125.0, 128.0, 129.0, 139.0, 161.0, 152.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 153.0, 153.0, 152.0, 155.0, 152.0, 156.0, 156.0, 156.0, 154.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 62.0, 63.0, 64.0, 66.0, 61.0, 61.0, 65.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1463.3999999999999, "alertThreshold": 2.0}]} 15:29:32 INFO - Return code: 0 15:29:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:29:32 INFO - # TBPL SUCCESS # 15:29:32 INFO - Running post-action listener: _resource_record_post_action 15:29:32 INFO - [mozharness: 2016-11-25 23:29:32.536867Z] Finished run-tests step (success) 15:29:32 INFO - Running post-run listener: _resource_record_post_run 15:29:32 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 327680; Write bytes: 356569088; Read time: 504; Write time: 236296 15:29:32 INFO - TinderboxPrint: CPU usage
13.0% 15:29:32 INFO - TinderboxPrint: I/O read bytes / time
327,680 / 504 15:29:32 INFO - TinderboxPrint: I/O write bytes / time
356,569,088 / 236,296 15:29:32 INFO - TinderboxPrint: CPU idle
8,282.1 (87.0%) 15:29:32 INFO - TinderboxPrint: CPU user
1,194.8 (12.5%) 15:29:32 INFO - TinderboxPrint: Swap in / out
0 / 0 15:29:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108208128; Read time: 136; Write time: 95164 15:29:32 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 319488; Write bytes: 248360960; Read time: 348; Write time: 141132 15:29:33 INFO - Running post-run listener: _upload_blobber_files 15:29:33 INFO - Blob upload gear active. 15:29:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:29:33 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 15:29:33 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'] 15:29:33 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 15:29:33 INFO - (blobuploader) - INFO - Open directory for files ... 15:29:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:29:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:29:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:29:37 INFO - (blobuploader) - INFO - Done attempting. 15:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:29:37 INFO - (blobuploader) - INFO - Done attempting. 15:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:29:38 INFO - (blobuploader) - INFO - Done attempting. 15:29:38 INFO - (blobuploader) - INFO - Iteration through files over. 15:29:38 INFO - Return code: 0 15:29:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:29:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:29:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/221dc5b94897bd0e15513c87640d4a3b35beb8edba548b9cdf6f9481a2eb878fe04ebb44534c70b5d5bce73eec814bf0dee36f95d370afae5f00f4d4073df7ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5323b3bf59d25692451fc1ed21138fc2fe6451a517ea93c6f107ebdacbddcebb903ca0f6048c60204796d8e08a4dd9f2470ec636292b3c257ba73f55ef0c8cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fac7f1adc6c869b5d490f98b8aef7ede6009578d345e9767c9021afbb9ecb3d15137f55663dbe613fa6324fe86fd7475f1b48205baef1649c286cf89d6ed973d"} 15:29:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:29:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:29:38 INFO - Contents: 15:29:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/221dc5b94897bd0e15513c87640d4a3b35beb8edba548b9cdf6f9481a2eb878fe04ebb44534c70b5d5bce73eec814bf0dee36f95d370afae5f00f4d4073df7ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5323b3bf59d25692451fc1ed21138fc2fe6451a517ea93c6f107ebdacbddcebb903ca0f6048c60204796d8e08a4dd9f2470ec636292b3c257ba73f55ef0c8cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fac7f1adc6c869b5d490f98b8aef7ede6009578d345e9767c9021afbb9ecb3d15137f55663dbe613fa6324fe86fd7475f1b48205baef1649c286cf89d6ed973d"} 15:29:38 INFO - Running post-run listener: copy_logs_to_upload_dir 15:29:38 INFO - Copying logs to upload dir... 15:29:38 INFO - mkdir: /builds/slave/test/build/upload/logs 15:29:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.071701 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-25 15:29:38.542721) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 15:29:38.546352) ========= 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=1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/221dc5b94897bd0e15513c87640d4a3b35beb8edba548b9cdf6f9481a2eb878fe04ebb44534c70b5d5bce73eec814bf0dee36f95d370afae5f00f4d4073df7ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5323b3bf59d25692451fc1ed21138fc2fe6451a517ea93c6f107ebdacbddcebb903ca0f6048c60204796d8e08a4dd9f2470ec636292b3c257ba73f55ef0c8cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fac7f1adc6c869b5d490f98b8aef7ede6009578d345e9767c9021afbb9ecb3d15137f55663dbe613fa6324fe86fd7475f1b48205baef1649c286cf89d6ed973d"} build_url:https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011813 build_url: 'https://queue.taskcluster.net/v1/task/aPyRBJ9rRj-2qVn6HNT0Eg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/221dc5b94897bd0e15513c87640d4a3b35beb8edba548b9cdf6f9481a2eb878fe04ebb44534c70b5d5bce73eec814bf0dee36f95d370afae5f00f4d4073df7ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5323b3bf59d25692451fc1ed21138fc2fe6451a517ea93c6f107ebdacbddcebb903ca0f6048c60204796d8e08a4dd9f2470ec636292b3c257ba73f55ef0c8cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fac7f1adc6c869b5d490f98b8aef7ede6009578d345e9767c9021afbb9ecb3d15137f55663dbe613fa6324fe86fd7475f1b48205baef1649c286cf89d6ed973d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 15:29:38.572965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 15:29:38.573348) ========= 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=1f5564757af27664ca02d71f000001b0-1480107603.656277-290758957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 15:29:38.655106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 15:29:38.655478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 15:29:38.655824) ========= ========= Total master_lag: 0.17 =========