builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1481863562.96 results: success (0) buildid: 20161215190549 builduid: bc1c88f563994f16bb1c247232f297ca revision: dd0f0ac09dbaab20b7dd217c6dff3c652fd8421a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:02.964476) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:02.965707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:02.965987) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:02.981170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:02.981615) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 20:46:03-- 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% 226M=0s 2016-12-15 20:46:03 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090958 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:03.086615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:03.086931) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018260 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:03.136506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:03.136862) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dd0f0ac09dbaab20b7dd217c6dff3c652fd8421a --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 dd0f0ac09dbaab20b7dd217c6dff3c652fd8421a --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=9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 20:46:03,629 truncating revision to first 12 chars 2016-12-15 20:46:03,629 Setting DEBUG logging. 2016-12-15 20:46:03,629 attempt 1/10 2016-12-15 20:46:03,629 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dd0f0ac09dba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 20:46:03,994 unpacking tar archive at: mozilla-aurora-dd0f0ac09dba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:03.840551) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:03.840915) ========= script_repo_revision: dd0f0ac09dbaab20b7dd217c6dff3c652fd8421a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:03.841294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:03.841572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 20:46:03.851394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-15 20:46:03.851692) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:46:04 INFO - MultiFileLogger online at 20161215 20:46:04 in /builds/slave/test 20:46:04 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 20:46:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:46:04 INFO - {'append_to_log': False, 20:46:04 INFO - 'base_work_dir': '/builds/slave/test', 20:46:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:46:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:46:04 INFO - 'branch': 'Mozilla-Aurora', 20:46:04 INFO - 'buildbot_json_path': 'buildprops.json', 20:46:04 INFO - 'config_files': ('talos/linux_config.py',), 20:46:04 INFO - 'default_actions': ('clobber', 20:46:04 INFO - 'read-buildbot-config', 20:46:04 INFO - 'download-and-extract', 20:46:04 INFO - 'populate-webroot', 20:46:04 INFO - 'create-virtualenv', 20:46:04 INFO - 'install', 20:46:04 INFO - 'run-tests'), 20:46:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:46:04 INFO - 'download_minidump_stackwalk': True, 20:46:04 INFO - 'download_symbols': 'ondemand', 20:46:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:46:04 INFO - 'tooltool.py': '/tools/tooltool.py', 20:46:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:46:04 INFO - '/tools/misc-python/virtualenv.py')}, 20:46:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:46:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:46:04 INFO - 'installer_path': 'installer.exe', 20:46:04 INFO - 'log_level': 'info', 20:46:04 INFO - 'log_name': 'talos', 20:46:04 INFO - 'log_to_console': True, 20:46:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:46:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:46:04 INFO - 'opt_config_files': (), 20:46:04 INFO - 'pip_index': False, 20:46:04 INFO - 'sps_profile': False, 20:46:04 INFO - 'sps_profile_interval': 0, 20:46:04 INFO - 'suite': 'dromaeojs', 20:46:04 INFO - 'system_bits': '32', 20:46:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:46:04 INFO - 'title': 'talos-linux64-ix-022', 20:46:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:46:04 INFO - 'use_talos_json': True, 20:46:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:46:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:46:04 INFO - 'work_dir': 'build'} 20:46:04 INFO - [mozharness: 2016-12-16 04:46:04.443190Z] Running clobber step. 20:46:04 INFO - Running pre-action listener: _resource_record_pre_action 20:46:04 INFO - Running main action method: clobber 20:46:04 INFO - rmtree: /builds/slave/test/build 20:46:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:46:05 INFO - Running post-action listener: _resource_record_post_action 20:46:05 INFO - [mozharness: 2016-12-16 04:46:05.419751Z] Finished clobber step (success) 20:46:05 INFO - [mozharness: 2016-12-16 04:46:05.419851Z] Running read-buildbot-config step. 20:46:05 INFO - Running pre-action listener: _resource_record_pre_action 20:46:05 INFO - Running main action method: read_buildbot_config 20:46:05 INFO - Using buildbot properties: 20:46:05 INFO - { 20:46:05 INFO - "project": "", 20:46:05 INFO - "product": "firefox", 20:46:05 INFO - "script_repo_revision": "production", 20:46:05 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:46:05 INFO - "repository": "", 20:46:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 20:46:05 INFO - "buildid": "20161215190549", 20:46:05 INFO - "pgo_build": "True", 20:46:05 INFO - "basedir": "/builds/slave/test", 20:46:05 INFO - "buildnumber": 639, 20:46:05 INFO - "slavename": "talos-linux64-ix-022", 20:46:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:46:05 INFO - "platform": "ubuntu64_hw", 20:46:05 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:46:05 INFO - "branch": "mozilla-aurora", 20:46:05 INFO - "repo_path": "releases/mozilla-aurora", 20:46:05 INFO - "revision": "dd0f0ac09dbaab20b7dd217c6dff3c652fd8421a", 20:46:05 INFO - "stage_platform": "linux64-pgo", 20:46:05 INFO - "builduid": "bc1c88f563994f16bb1c247232f297ca", 20:46:05 INFO - "slavebuilddir": "test" 20:46:05 INFO - } 20:46:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 20:46:05 INFO - Running post-action listener: _resource_record_post_action 20:46:05 INFO - [mozharness: 2016-12-16 04:46:05.422254Z] Finished read-buildbot-config step (success) 20:46:05 INFO - [mozharness: 2016-12-16 04:46:05.422342Z] Running download-and-extract step. 20:46:05 INFO - Running pre-action listener: _resource_record_pre_action 20:46:05 INFO - Running main action method: download_and_extract 20:46:05 INFO - mkdir: /builds/slave/test/build/tests 20:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:05 INFO - trying https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:46:05 INFO - Downloading https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/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 20:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/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 20:46:06 INFO - Downloaded 1361 bytes. 20:46:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:46:06 INFO - Using the following test package requirements: 20:46:06 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 20:46:06 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:46:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:46:06 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:46:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:46:06 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:46:06 INFO - u'jsshell-linux-x86_64.zip'], 20:46:06 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:46:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:46:06 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 20:46:06 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:46:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:46:06 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:46:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:46:06 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:46:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:46:06 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:46:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:46:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:46:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 20:46:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:46:06 INFO - Fetch https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:46:06 INFO - Http code: 200 20:46:06 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 20:46:06 INFO - x-amz-cf-id: qNh4uE0Uskg58DyyfKR64XuGjZy4kanCCUhO5jsm3a6wWEBc9bBYqw== 20:46:06 INFO - x-amz-version-id: VwqgNfctcKA3qN6rIcAEZ8sAQiBC2xzm 20:46:06 INFO - Expected file size: 21952232 20:46:06 INFO - Obtained file size: 21952232 20:46:10 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 20:46:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 20:46:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:46:10 INFO - Fetch https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:46:11 INFO - Http code: 200 20:46:11 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 20:46:11 INFO - x-amz-cf-id: Qdhxvq3IxGsKBEz7s-AkJcVcxCBs_PBS_bZMfiWgX-Rg7TcbM7Hrfg== 20:46:11 INFO - x-amz-version-id: VwqgNfctcKA3qN6rIcAEZ8sAQiBC2xzm 20:46:11 INFO - Expected file size: 21952232 20:46:11 INFO - Obtained file size: 21952232 20:46:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 20:46:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:46:16 INFO - Fetch https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 20:46:16 INFO - Http code: 200 20:46:16 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 20:46:16 INFO - x-amz-cf-id: D18uvRxKoDVICCwJmcfQKqb-PM2khQBqGanoAinhIVvS7yMf0Fw_PQ== 20:46:16 INFO - x-amz-version-id: diYLYEI3LIOmY6XUYx39uIrK_oFYlkSl 20:46:16 INFO - Expected file size: 14409038 20:46:16 INFO - Obtained file size: 14409038 20:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:17 INFO - trying https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:46:17 INFO - Downloading https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/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 20:46:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/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 20:46:18 INFO - Downloaded 63951817 bytes. 20:46:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:46:18 INFO - mkdir: /builds/slave/test/properties 20:46:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:46:18 INFO - Writing to file /builds/slave/test/properties/build_url 20:46:18 INFO - Contents: 20:46:18 INFO - build_url:https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:46:18 INFO - Running post-action listener: _resource_record_post_action 20:46:18 INFO - Running post-action listener: set_extra_try_arguments 20:46:18 INFO - [mozharness: 2016-12-16 04:46:18.854529Z] Finished download-and-extract step (success) 20:46:18 INFO - [mozharness: 2016-12-16 04:46:18.854755Z] Running populate-webroot step. 20:46:18 INFO - Running pre-action listener: _resource_record_pre_action 20:46:18 INFO - Running main action method: populate_webroot 20:46:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:46:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:46:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:46:18 INFO - '--tppagecycles', 20:46:18 INFO - '7'], 20:46:18 INFO - 'tests': ['tsvgm']}}, 20:46:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:46:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:46:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:46:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:46:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:18 INFO - 'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:18 INFO - 'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['damp', 'tps']}, 20:46:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:18 INFO - 'tests': ['damp', 'tps']}, 20:46:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['dromaeo_dom']}, 20:46:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:46:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['basic_compositor_video']}, 20:46:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:46:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['a11yr', 20:46:18 INFO - 'ts_paint', 20:46:18 INFO - 'tpaint', 20:46:18 INFO - 'sessionrestore', 20:46:18 INFO - 'sessionrestore_no_auto_restore', 20:46:18 INFO - 'tabpaint']}, 20:46:18 INFO - 'other-e10s': {'tests': ['a11yr', 20:46:18 INFO - 'ts_paint', 20:46:18 INFO - 'tpaint', 20:46:18 INFO - 'sessionrestore', 20:46:18 INFO - 'sessionrestore_no_auto_restore', 20:46:18 INFO - 'tabpaint']}, 20:46:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:46:18 INFO - 'ts_paint', 20:46:18 INFO - 'tpaint', 20:46:18 INFO - 'sessionrestore', 20:46:18 INFO - 'sessionrestore_no_auto_restore', 20:46:18 INFO - 'tabpaint']}, 20:46:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:46:18 INFO - 'ts_paint', 20:46:18 INFO - 'tpaint', 20:46:18 INFO - 'sessionrestore', 20:46:18 INFO - 'sessionrestore_no_auto_restore', 20:46:18 INFO - 'tabpaint']}, 20:46:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['a11yr', 20:46:18 INFO - 'ts_paint', 20:46:18 INFO - 'tpaint', 20:46:18 INFO - 'sessionrestore', 20:46:18 INFO - 'sessionrestore_no_auto_restore', 20:46:18 INFO - 'tabpaint']}, 20:46:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['a11yr', 20:46:18 INFO - 'ts_paint', 20:46:18 INFO - 'tpaint', 20:46:18 INFO - 'sessionrestore', 20:46:18 INFO - 'sessionrestore_no_auto_restore', 20:46:18 INFO - 'tabpaint']}, 20:46:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['tsvgx', 20:46:18 INFO - 'tsvgr_opacity', 20:46:18 INFO - 'tart', 20:46:18 INFO - 'tscrollx', 20:46:18 INFO - 'cart']}, 20:46:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:46:18 INFO - 'tsvgr_opacity', 20:46:18 INFO - 'tart', 20:46:18 INFO - 'tscrollx', 20:46:18 INFO - 'cart']}, 20:46:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:18 INFO - 'talos_options': ['--disable-e10s'], 20:46:18 INFO - 'tests': ['tp5o']}, 20:46:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:18 INFO - 'tests': ['tp5o']}, 20:46:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:18 INFO - 'talos_options': ['--disable-e10s', 20:46:18 INFO - '--xperf_path', 20:46:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:18 INFO - 'tests': ['tp5n']}, 20:46:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:18 INFO - 'talos_options': ['--xperf_path', 20:46:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:18 INFO - 'tests': ['tp5n']}}, 20:46:18 INFO - 'talos.zip': {'path': '', 20:46:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:46:18 INFO - Running post-action listener: _resource_record_post_action 20:46:18 INFO - [mozharness: 2016-12-16 04:46:18.873850Z] Finished populate-webroot step (success) 20:46:18 INFO - [mozharness: 2016-12-16 04:46:18.873937Z] Running create-virtualenv step. 20:46:18 INFO - Running pre-action listener: _resource_record_pre_action 20:46:18 INFO - Running main action method: create_virtualenv 20:46:18 INFO - Creating virtualenv /builds/slave/test/build/venv 20:46:18 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 20:46:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:46:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:46:18 INFO - Using real prefix '/usr' 20:46:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:46:19 INFO - Installing distribute.............................................................................................................................................................................................done. 20:46:21 INFO - Installing pip.................done. 20:46:21 INFO - Return code: 0 20:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:46:21 INFO - Reading from file tmpfile_stdout 20:46:21 INFO - Output received: 20:46:21 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) 20:46:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:46:21 INFO - Using env: {'DISPLAY': ':0', 20:46:21 INFO - 'HOME': '/home/cltbld', 20:46:21 INFO - 'LANG': 'en_US.UTF-8', 20:46:21 INFO - 'LANGUAGE': 'en_US:en', 20:46:21 INFO - 'LOGNAME': 'cltbld', 20:46:21 INFO - 'MAIL': '/var/mail/cltbld', 20:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:21 INFO - 'MOZ_NO_REMOTE': '1', 20:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:21 INFO - 'NO_EM_RESTART': '1', 20:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:21 INFO - 'PWD': '/builds/slave/test', 20:46:21 INFO - 'SHELL': '/bin/bash', 20:46:21 INFO - 'SHLVL': '1', 20:46:21 INFO - 'TERM': 'linux', 20:46:21 INFO - 'TMOUT': '86400', 20:46:21 INFO - 'USER': 'cltbld', 20:46:21 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:21 INFO - '_': '/tools/buildbot/bin/python'} 20:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:21 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 20:46:21 INFO - Cleaning up... 20:46:21 INFO - Return code: 0 20:46:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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', '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 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:46: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 psutil>=3.1.1 20:46:22 INFO - Using env: {'DISPLAY': ':0', 20:46:22 INFO - 'HOME': '/home/cltbld', 20:46:22 INFO - 'LANG': 'en_US.UTF-8', 20:46:22 INFO - 'LANGUAGE': 'en_US:en', 20:46:22 INFO - 'LOGNAME': 'cltbld', 20:46:22 INFO - 'MAIL': '/var/mail/cltbld', 20:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:22 INFO - 'MOZ_NO_REMOTE': '1', 20:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:22 INFO - 'NO_EM_RESTART': '1', 20:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:22 INFO - 'PWD': '/builds/slave/test', 20:46:22 INFO - 'SHELL': '/bin/bash', 20:46:22 INFO - 'SHLVL': '1', 20:46:22 INFO - 'TERM': 'linux', 20:46:22 INFO - 'TMOUT': '86400', 20:46:22 INFO - 'USER': 'cltbld', 20:46:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:22 INFO - '_': '/tools/buildbot/bin/python'} 20:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:22 INFO - Downloading/unpacking psutil>=3.1.1 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:46:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:24 INFO - Installing collected packages: psutil 20:46:24 INFO - Running setup.py install for psutil 20:46:24 INFO - building 'psutil._psutil_linux' extension 20:46:24 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 20:46:24 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 20:46:24 INFO - building 'psutil._psutil_posix' extension 20:46:24 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 20:46:24 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 20:46:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:24 INFO - Successfully installed psutil 20:46:24 INFO - Cleaning up... 20:46:24 INFO - Return code: 0 20:46:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:46: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')]} 20:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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')]} 20:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:46: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 mozsystemmonitor==0.3 20:46:24 INFO - Using env: {'DISPLAY': ':0', 20:46:24 INFO - 'HOME': '/home/cltbld', 20:46:24 INFO - 'LANG': 'en_US.UTF-8', 20:46:24 INFO - 'LANGUAGE': 'en_US:en', 20:46:24 INFO - 'LOGNAME': 'cltbld', 20:46:24 INFO - 'MAIL': '/var/mail/cltbld', 20:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:24 INFO - 'MOZ_NO_REMOTE': '1', 20:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:24 INFO - 'NO_EM_RESTART': '1', 20:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:24 INFO - 'PWD': '/builds/slave/test', 20:46:24 INFO - 'SHELL': '/bin/bash', 20:46:24 INFO - 'SHLVL': '1', 20:46:24 INFO - 'TERM': 'linux', 20:46:24 INFO - 'TMOUT': '86400', 20:46:24 INFO - 'USER': 'cltbld', 20:46:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:24 INFO - '_': '/tools/buildbot/bin/python'} 20:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:46:27 INFO - Installing collected packages: mozsystemmonitor 20:46:27 INFO - Running setup.py install for mozsystemmonitor 20:46:27 INFO - Successfully installed mozsystemmonitor 20:46:27 INFO - Cleaning up... 20:46:27 INFO - Return code: 0 20:46:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:46: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')]} 20:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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')]} 20:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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', '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 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:46: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 jsonschema==2.5.1 20:46:27 INFO - Using env: {'DISPLAY': ':0', 20:46:27 INFO - 'HOME': '/home/cltbld', 20:46:27 INFO - 'LANG': 'en_US.UTF-8', 20:46:27 INFO - 'LANGUAGE': 'en_US:en', 20:46:27 INFO - 'LOGNAME': 'cltbld', 20:46:27 INFO - 'MAIL': '/var/mail/cltbld', 20:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:27 INFO - 'MOZ_NO_REMOTE': '1', 20:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:27 INFO - 'NO_EM_RESTART': '1', 20:46:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:27 INFO - 'PWD': '/builds/slave/test', 20:46:27 INFO - 'SHELL': '/bin/bash', 20:46:27 INFO - 'SHLVL': '1', 20:46:27 INFO - 'TERM': 'linux', 20:46:27 INFO - 'TMOUT': '86400', 20:46:27 INFO - 'USER': 'cltbld', 20:46:27 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:27 INFO - '_': '/tools/buildbot/bin/python'} 20:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:27 INFO - Downloading/unpacking jsonschema==2.5.1 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:46:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:29 INFO - Downloading functools32-3.2.3-2.tar.gz 20:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:46:29 INFO - warning: no files found matching '*.txt' 20:46:29 INFO - no previously-included directories found matching 'build' 20:46:29 INFO - no previously-included directories found matching 'dist' 20:46:29 INFO - no previously-included directories found matching '.git*' 20:46:29 INFO - Installing collected packages: jsonschema, functools32 20:46:29 INFO - Running setup.py install for functools32 20:46:30 INFO - warning: no files found matching '*.txt' 20:46:30 INFO - no previously-included directories found matching 'build' 20:46:30 INFO - no previously-included directories found matching 'dist' 20:46:30 INFO - no previously-included directories found matching '.git*' 20:46:30 INFO - Successfully installed jsonschema functools32 20:46:30 INFO - Cleaning up... 20:46:30 INFO - Return code: 0 20:46:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:46:30 INFO - Using env: {'DISPLAY': ':0', 20:46:30 INFO - 'HOME': '/home/cltbld', 20:46:30 INFO - 'LANG': 'en_US.UTF-8', 20:46:30 INFO - 'LANGUAGE': 'en_US:en', 20:46:30 INFO - 'LOGNAME': 'cltbld', 20:46:30 INFO - 'MAIL': '/var/mail/cltbld', 20:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:30 INFO - 'MOZ_NO_REMOTE': '1', 20:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:30 INFO - 'NO_EM_RESTART': '1', 20:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:30 INFO - 'PWD': '/builds/slave/test', 20:46:30 INFO - 'SHELL': '/bin/bash', 20:46:30 INFO - 'SHLVL': '1', 20:46:30 INFO - 'TERM': 'linux', 20:46:30 INFO - 'TMOUT': '86400', 20:46:30 INFO - 'USER': 'cltbld', 20:46:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:30 INFO - '_': '/tools/buildbot/bin/python'} 20:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:46:30 INFO - Cleaning up... 20:46:30 INFO - Return code: 0 20:46:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:46:30 INFO - Using env: {'DISPLAY': ':0', 20:46:30 INFO - 'HOME': '/home/cltbld', 20:46:30 INFO - 'LANG': 'en_US.UTF-8', 20:46:30 INFO - 'LANGUAGE': 'en_US:en', 20:46:30 INFO - 'LOGNAME': 'cltbld', 20:46:30 INFO - 'MAIL': '/var/mail/cltbld', 20:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:30 INFO - 'MOZ_NO_REMOTE': '1', 20:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:30 INFO - 'NO_EM_RESTART': '1', 20:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:30 INFO - 'PWD': '/builds/slave/test', 20:46:30 INFO - 'SHELL': '/bin/bash', 20:46:30 INFO - 'SHLVL': '1', 20:46:30 INFO - 'TERM': 'linux', 20:46:30 INFO - 'TMOUT': '86400', 20:46:30 INFO - 'USER': 'cltbld', 20:46:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:30 INFO - '_': '/tools/buildbot/bin/python'} 20:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:30 INFO - Downloading/unpacking blobuploader==1.2.4 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:32 INFO - Downloading blobuploader-1.2.4.tar.gz 20:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:46:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:46:32 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 20:46:32 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 20:46:32 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 20:46:32 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 20:46:32 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 20:46:32 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 20:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:46:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:46:33 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 20:46:33 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 20:46:33 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 20:46:33 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 20:46:33 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 20:46:33 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 20:46:33 INFO - Downloading docopt-0.6.1.tar.gz 20:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:46:33 INFO - Installing collected packages: blobuploader, requests, docopt 20:46:33 INFO - Running setup.py install for blobuploader 20:46:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:46:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:46:33 INFO - Running setup.py install for requests 20:46:33 INFO - Running setup.py install for docopt 20:46:33 INFO - Successfully installed blobuploader requests docopt 20:46:33 INFO - Cleaning up... 20:46:33 INFO - Return code: 0 20:46:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:33 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 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46:33 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 20:46:33 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 20:46:33 INFO - Using env: {'DISPLAY': ':0', 20:46:33 INFO - 'HOME': '/home/cltbld', 20:46:33 INFO - 'LANG': 'en_US.UTF-8', 20:46:33 INFO - 'LANGUAGE': 'en_US:en', 20:46:33 INFO - 'LOGNAME': 'cltbld', 20:46:33 INFO - 'MAIL': '/var/mail/cltbld', 20:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:33 INFO - 'MOZ_NO_REMOTE': '1', 20:46:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:33 INFO - 'NO_EM_RESTART': '1', 20:46:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:33 INFO - 'PWD': '/builds/slave/test', 20:46:33 INFO - 'SHELL': '/bin/bash', 20:46:33 INFO - 'SHLVL': '1', 20:46:33 INFO - 'TERM': 'linux', 20:46:33 INFO - 'TMOUT': '86400', 20:46:33 INFO - 'USER': 'cltbld', 20:46:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:33 INFO - '_': '/tools/buildbot/bin/python'} 20:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:34 INFO - Running setup.py (path:/tmp/pip-fdTXOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:34 INFO - Running setup.py (path:/tmp/pip-byo3cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:34 INFO - Running setup.py (path:/tmp/pip-Rt5O7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:34 INFO - Running setup.py (path:/tmp/pip-FJfmD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:34 INFO - Running setup.py (path:/tmp/pip-XbhrdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:34 INFO - Running setup.py (path:/tmp/pip-cP6Frk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:34 INFO - Running setup.py (path:/tmp/pip-krRGXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:34 INFO - Running setup.py (path:/tmp/pip-bos8A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:34 INFO - Running setup.py (path:/tmp/pip-WhaLBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:34 INFO - Running setup.py (path:/tmp/pip-paQRUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:34 INFO - Running setup.py (path:/tmp/pip-_hpfuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:34 INFO - Running setup.py (path:/tmp/pip-MEwrzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:35 INFO - Running setup.py (path:/tmp/pip-flcF43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:35 INFO - Running setup.py (path:/tmp/pip-Ao5n33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:35 INFO - Running setup.py (path:/tmp/pip-lsGLUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:35 INFO - Running setup.py (path:/tmp/pip-OTV81P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:35 INFO - Running setup.py (path:/tmp/pip-oJsoAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:46:35 INFO - Running setup.py install for manifestparser 20:46:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:46:35 INFO - Running setup.py install for mozcrash 20:46:35 INFO - Running setup.py install for mozdebug 20:46:35 INFO - Running setup.py install for mozdevice 20:46:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:46:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:46:35 INFO - Running setup.py install for mozfile 20:46:35 INFO - Running setup.py install for mozhttpd 20:46:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Running setup.py install for mozinfo 20:46:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Running setup.py install for mozInstall 20:46:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Running setup.py install for mozleak 20:46:36 INFO - Running setup.py install for mozlog 20:46:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Running setup.py install for moznetwork 20:46:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Running setup.py install for mozprocess 20:46:36 INFO - Running setup.py install for mozprofile 20:46:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Running setup.py install for mozrunner 20:46:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:46:36 INFO - Running setup.py install for mozscreenshot 20:46:36 INFO - Running setup.py install for moztest 20:46:37 INFO - Running setup.py install for mozversion 20:46:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:46:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:46:37 INFO - Cleaning up... 20:46:37 INFO - Return code: 0 20:46:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:37 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')]} 20:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:37 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')]} 20:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:37 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 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46:37 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 20:46:37 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 20:46:37 INFO - Using env: {'DISPLAY': ':0', 20:46:37 INFO - 'HOME': '/home/cltbld', 20:46:37 INFO - 'LANG': 'en_US.UTF-8', 20:46:37 INFO - 'LANGUAGE': 'en_US:en', 20:46:37 INFO - 'LOGNAME': 'cltbld', 20:46:37 INFO - 'MAIL': '/var/mail/cltbld', 20:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:37 INFO - 'MOZ_NO_REMOTE': '1', 20:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:37 INFO - 'NO_EM_RESTART': '1', 20:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:37 INFO - 'PWD': '/builds/slave/test', 20:46:37 INFO - 'SHELL': '/bin/bash', 20:46:37 INFO - 'SHLVL': '1', 20:46:37 INFO - 'TERM': 'linux', 20:46:37 INFO - 'TMOUT': '86400', 20:46:37 INFO - 'USER': 'cltbld', 20:46:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:37 INFO - '_': '/tools/buildbot/bin/python'} 20:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:37 INFO - Running setup.py (path:/tmp/pip-NoloFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:37 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)) 20:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:37 INFO - Running setup.py (path:/tmp/pip-n3whl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:37 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)) 20:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:37 INFO - Running setup.py (path:/tmp/pip-GVv3Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:37 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)) 20:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:37 INFO - Running setup.py (path:/tmp/pip-7I4aMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:37 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)) 20:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:37 INFO - Running setup.py (path:/tmp/pip-aJKp4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:37 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)) 20:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:37 INFO - Running setup.py (path:/tmp/pip-lEkacr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:37 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)) 20:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:37 INFO - Running setup.py (path:/tmp/pip-nPMeat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:37 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)) 20:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:37 INFO - Running setup.py (path:/tmp/pip-veRHiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:38 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)) 20:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:38 INFO - Running setup.py (path:/tmp/pip-iZ0fMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:38 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)) 20:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:38 INFO - Running setup.py (path:/tmp/pip-Ncsmal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:38 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)) 20:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:38 INFO - Running setup.py (path:/tmp/pip-Y57JUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:38 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)) 20:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:38 INFO - Running setup.py (path:/tmp/pip-8Qdl9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:38 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)) 20:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:38 INFO - Running setup.py (path:/tmp/pip-l6PXEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:38 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)) 20:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:38 INFO - Running setup.py (path:/tmp/pip-sWSl1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:38 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)) 20:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:38 INFO - Running setup.py (path:/tmp/pip-8OGOsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:38 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)) 20:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:38 INFO - Running setup.py (path:/tmp/pip-LU_HIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:38 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)) 20:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:38 INFO - Running setup.py (path:/tmp/pip-nxBmLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:38 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)) 20:46:38 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)) 20:46:38 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)) 20:46:38 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)) 20:46:38 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)) 20:46:38 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)) 20:46:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:46:38 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 20:46:38 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 20:46:38 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 20:46:38 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 20:46:38 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 20:46:38 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 20:46:40 INFO - Downloading blessings-1.6.tar.gz 20:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:46:40 INFO - Installing collected packages: blessings 20:46:40 INFO - Running setup.py install for blessings 20:46:40 INFO - Successfully installed blessings 20:46:40 INFO - Cleaning up... 20:46:40 INFO - Return code: 0 20:46:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:46:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:41 INFO - Reading from file tmpfile_stdout 20:46:41 INFO - Current package versions: 20:46:41 INFO - argparse == 1.2.1 20:46:41 INFO - blessings == 1.6 20:46:41 INFO - blobuploader == 1.2.4 20:46:41 INFO - docopt == 0.6.1 20:46:41 INFO - functools32 == 3.2.3-2 20:46:41 INFO - jsonschema == 2.5.1 20:46:41 INFO - manifestparser == 1.1 20:46:41 INFO - mozInstall == 1.12 20:46:41 INFO - mozcrash == 1.0 20:46:41 INFO - mozdebug == 0.1 20:46:41 INFO - mozdevice == 0.48 20:46:41 INFO - mozfile == 1.2 20:46:41 INFO - mozhttpd == 0.7 20:46:41 INFO - mozinfo == 0.9 20:46:41 INFO - mozleak == 0.1 20:46:41 INFO - mozlog == 3.4 20:46:41 INFO - moznetwork == 0.27 20:46:41 INFO - mozprocess == 0.23 20:46:41 INFO - mozprofile == 0.28 20:46:41 INFO - mozrunner == 6.13 20:46:41 INFO - mozscreenshot == 0.1 20:46:41 INFO - mozsystemmonitor == 0.3 20:46:41 INFO - moztest == 0.7 20:46:41 INFO - mozversion == 1.4 20:46:41 INFO - psutil == 3.1.1 20:46:41 INFO - requests == 1.2.3 20:46:41 INFO - wsgiref == 0.1.2 20:46:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:41 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 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46:41 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 20:46:41 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 20:46:41 INFO - Using env: {'DISPLAY': ':0', 20:46:41 INFO - 'HOME': '/home/cltbld', 20:46:41 INFO - 'LANG': 'en_US.UTF-8', 20:46:41 INFO - 'LANGUAGE': 'en_US:en', 20:46:41 INFO - 'LOGNAME': 'cltbld', 20:46:41 INFO - 'MAIL': '/var/mail/cltbld', 20:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:41 INFO - 'MOZ_NO_REMOTE': '1', 20:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:41 INFO - 'NO_EM_RESTART': '1', 20:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:41 INFO - 'PWD': '/builds/slave/test', 20:46:41 INFO - 'SHELL': '/bin/bash', 20:46:41 INFO - 'SHLVL': '1', 20:46:41 INFO - 'TERM': 'linux', 20:46:41 INFO - 'TMOUT': '86400', 20:46:41 INFO - 'USER': 'cltbld', 20:46:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:41 INFO - '_': '/tools/buildbot/bin/python'} 20:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:41 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)) 20:46:41 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)) 20:46:41 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)) 20:46:41 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)) 20:46:41 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)) 20:46:41 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)) 20:46:41 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)) 20:46:41 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)) 20:46:41 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)) 20:46:41 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)) 20:46:41 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)) 20:46:41 INFO - Cleaning up... 20:46:41 INFO - Return code: 0 20:46:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:41 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 0x7f0b10a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1793ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', '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 20:46:41 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 20:46:41 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 20:46:41 INFO - Using env: {'DISPLAY': ':0', 20:46:41 INFO - 'HOME': '/home/cltbld', 20:46:41 INFO - 'LANG': 'en_US.UTF-8', 20:46:41 INFO - 'LANGUAGE': 'en_US:en', 20:46:41 INFO - 'LOGNAME': 'cltbld', 20:46:41 INFO - 'MAIL': '/var/mail/cltbld', 20:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:41 INFO - 'MOZ_NO_REMOTE': '1', 20:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:41 INFO - 'NO_EM_RESTART': '1', 20:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:41 INFO - 'PWD': '/builds/slave/test', 20:46:41 INFO - 'SHELL': '/bin/bash', 20:46:41 INFO - 'SHLVL': '1', 20:46:41 INFO - 'TERM': 'linux', 20:46:41 INFO - 'TMOUT': '86400', 20:46:41 INFO - 'USER': 'cltbld', 20:46:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:41 INFO - '_': '/tools/buildbot/bin/python'} 20:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:46:41 INFO - Cleaning up... 20:46:41 INFO - Return code: 0 20:46:41 INFO - Running post-action listener: _resource_record_post_action 20:46:41 INFO - Running post-action listener: _start_resource_monitoring 20:46:41 INFO - Starting resource monitoring. 20:46:41 INFO - [mozharness: 2016-12-16 04:46:41.576149Z] Finished create-virtualenv step (success) 20:46:41 INFO - [mozharness: 2016-12-16 04:46:41.576657Z] Running install step. 20:46:41 INFO - Running pre-action listener: _resource_record_pre_action 20:46:41 INFO - Running main action method: install 20:46:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:41 INFO - Reading from file tmpfile_stdout 20:46:41 INFO - Detecting whether we're running mozinstall >=1.0... 20:46:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:46:41 INFO - Reading from file tmpfile_stdout 20:46:41 INFO - Output received: 20:46:41 INFO - Usage: mozinstall [options] installer 20:46:41 INFO - Options: 20:46:41 INFO - -h, --help show this help message and exit 20:46:41 INFO - -d DEST, --destination=DEST 20:46:41 INFO - Directory to install application into. [default: 20:46:41 INFO - "/builds/slave/test"] 20:46:41 INFO - --app=APP Application being installed. [default: firefox] 20:46:41 INFO - mkdir: /builds/slave/test/build/application 20:46:41 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'] 20:46:41 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 20:46:57 INFO - Reading from file tmpfile_stdout 20:46:57 INFO - Output received: 20:46:57 INFO - /builds/slave/test/build/application/firefox/firefox 20:46:57 INFO - Running post-action listener: _resource_record_post_action 20:46:57 INFO - [mozharness: 2016-12-16 04:46:57.783247Z] Finished install step (success) 20:46:57 INFO - [mozharness: 2016-12-16 04:46:57.783492Z] Running run-tests step. 20:46:57 INFO - Running pre-action listener: _resource_record_pre_action 20:46:57 INFO - Running main action method: run_tests 20:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:46:57 INFO - Python 2.7.3 20:46:57 INFO - Return code: 0 20:46:57 INFO - grabbing minidump binary from tooltool 20:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:57 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 0x1790f60>, '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 0x1791d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17921d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:46:57 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 20:46:57 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 20:46:57 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 20:46:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:46:57 INFO - Return code: 0 20:46:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:46:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:46:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:46:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:46:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:46:57 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/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 20:46:57 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/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 20:46:57 INFO - Using env: {'DISPLAY': ':0', 20:46:57 INFO - 'HOME': '/home/cltbld', 20:46:57 INFO - 'LANG': 'en_US.UTF-8', 20:46:57 INFO - 'LANGUAGE': 'en_US:en', 20:46:57 INFO - 'LOGNAME': 'cltbld', 20:46:57 INFO - 'MAIL': '/var/mail/cltbld', 20:46:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:46:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:57 INFO - 'MOZ_NO_REMOTE': '1', 20:46:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:57 INFO - 'NO_EM_RESTART': '1', 20:46:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:57 INFO - 'PWD': '/builds/slave/test', 20:46:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:46:57 INFO - 'SHELL': '/bin/bash', 20:46:57 INFO - 'SHLVL': '1', 20:46:57 INFO - 'TERM': 'linux', 20:46:57 INFO - 'TMOUT': '86400', 20:46:57 INFO - 'USER': 'cltbld', 20:46:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329', 20:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:57 INFO - '_': '/tools/buildbot/bin/python'} 20:46:57 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/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 20:46:58 INFO - mozversion application_buildid: 20161215190549 20:46:58 INFO - mozversion application_changeset: dd0f0ac09dbaab20b7dd217c6dff3c652fd8421a 20:46:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:46:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:46:58 INFO - mozversion application_name: Firefox 20:46:58 INFO - mozversion application_remotingname: firefox-dev 20:46:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:46:58 INFO - mozversion application_vendor: Mozilla 20:46:58 INFO - mozversion application_version: 52.0a2 20:46:58 INFO - mozversion platform_buildid: 20161215190549 20:46:58 INFO - mozversion platform_changeset: dd0f0ac09dbaab20b7dd217c6dff3c652fd8421a 20:46:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:46:58 INFO - mozversion platform_version: 52.0a2 20:46:58 INFO - using testdate: 1481863618 20:46:58 INFO - actual date: 1481863618 20:46:58 INFO - starting webserver on 'localhost:34810' 20:46:58 INFO - SUITE-START | Running 2 tests 20:46:58 INFO - TEST-START | dromaeo_css 20:46:58 INFO - operating with platform_type : linux_ 20:46:58 INFO - Initialising browser for dromaeo_css test... 20:46:58 INFO - TEST-INFO | started process 752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw6Yrgb/profile http://localhost:34810/getInfo.html) 20:47:02 INFO - PROCESS | 752 | __metrics Screen width/height:1600/1200 20:47:02 INFO - PROCESS | 752 | colorDepth:24 20:47:02 INFO - PROCESS | 752 | Browser inner width/height: 1024/697 20:47:02 INFO - PROCESS | 752 | __metrics 20:47:02 INFO - PROCESS | 752 | 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" 20:47:02 INFO - PROCESS | 752 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:47:03 INFO - PROCESS | 752 | console.error: PushService: 20:47:03 INFO - PROCESS | 752 | stateChangeProcessEnqueue: Error transitioning state 20:47:03 INFO - PROCESS | 752 | UnknownError 20:47:03 INFO - TEST-INFO | 752: exit 0 20:47:03 INFO - Browser initialized. 20:47:03 INFO - Running cycle 1/1 for dromaeo_css test... 20:47:03 INFO - TEST-INFO | started process 852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw6Yrgb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:47:15 INFO - PROCESS | 852 | RSS: Main: 144269312 20:47:15 INFO - PROCESS | 852 | 20:48:07 INFO - PROCESS | 852 | 1481863687324 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] 20:50:17 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:34810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34810/tests/dromaeo/cssquery-ext.html) 20:50:19 INFO - PROCESS | 852 | RSS: Main: 244314112 20:50:19 INFO - PROCESS | 852 | 20:53:21 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:34810/tests/dromaeo/cssquery-ext.html (next: http://localhost:34810/tests/dromaeo/cssquery-jquery.html) 20:53:21 INFO - PROCESS | 852 | RSS: Main: 220987392 20:53:21 INFO - PROCESS | 852 | 20:56:23 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:34810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34810/tests/dromaeo/cssquery-mootools.html) 20:56:24 INFO - PROCESS | 852 | RSS: Main: 221290496 20:56:24 INFO - PROCESS | 852 | 20:59:26 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:34810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34810/tests/dromaeo/cssquery-prototype.html) 20:59:26 INFO - PROCESS | 852 | RSS: Main: 218050560 20:59:26 INFO - PROCESS | 852 | 21:02:29 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:34810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34810/tests/dromaeo/cssquery-yui.html) 21:02:30 INFO - PROCESS | 852 | RSS: Main: 175161344 21:02:30 INFO - PROCESS | 852 | 21:05:32 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:34810/tests/dromaeo/cssquery-yui.html (next: http://localhost:34810/tests/dromaeo/cssquery-dojo.html) 21:05:32 INFO - PROCESS | 852 | RSS: Main: 263155712 21:05:32 INFO - PROCESS | 852 | 21:05:32 INFO - PROCESS | 852 | __start_tp_report 21:05:32 INFO - PROCESS | 852 | _x_x_mozilla_page_load 21:05:32 INFO - PROCESS | 852 | _x_x_mozilla_page_load_details 21:05:32 INFO - PROCESS | 852 | |i|pagename|runs| 21:05:32 INFO - PROCESS | 852 | |0;dojo.html;3161.8102913825173;3167.1607024138602;3167.4456970030246;3184.538241954915;3199.1202419334695;5322.973385133074;5376.301080859487;5404;5425.213344065108;5447.264619276397;5449;5472.91790623141;5474.644148130379;5477.616566840323;5488.012157811602;4941.62937779667;4954.826581069663;5022.372203474566;5022.623303252252;5035.043341765071;4965.205567109263;4993.226049962243;5057.924131138036;5065.848024559269;5086.415062267831;4954.3063971044085;4980.6762560433635;5020.447750747415;5061.54446099851;5073.492650734934;4997.350344455216;5039.143345631252;5040.092783299005;5090.694558326512;5133.640645154841;4986.252062190664;5014.6991180529285;5052.696838189684;5067.974660126676;5071.594272458195;5304.443033481468;5368.973155134238;5391.433899440581;5393.083175860074;5429.4299098594865;5818.2145410369485;5821.708914554298;5892.882142357172;5924.200232968537;5933.258342707161;5731.083026715747;5915.792947246869;5924.318703349127;5959.344472108065;5974.044152935553;5394.595405344576;5458.91811622822;5478.890422191534;5491.670499770026;5568.359638641527;6019.157317975487;6044.063170208625;6049.8487537811025;6053.697315134225;6067.969660151671;5678.14827775837;5814.418558144236;5820.912686309709;5821.09772985188;5827.271591051119;5749.223854779551;5785.595008349459;5792.623479473821;5800.8259752207505;5894.616849904743;5825.0388685866355;5838.2702162229725;5842.415758424208;5848.941510584925;5882.029465138205;5782.219400380979;5831.708414579254;5835.94164058354;5843.357230704619;5851.561132915049;4490.101979604092;4495.100979803987;4551.749653769009;4566.246569316092;4573.862784116482;4029.4560234368573;4052.878413647595;4070.61329173728;4079.9796001019804;4089.8364065437645;5622.437756224426;5632.8028519002455;5634.549236061105;5645.096784514458;5674.858128546819;5747.166660834239;5789.8552536186935;5857.355690874;5910.940890591125;5914.112883067574;5664.20701101846;5665.12190610456;5675.404082571353;5688.260526131659;5702.54379649627;5162.5095615916425;5176.81881134166;5180.818671346485;5183.067047931333;5230.0585894539345;5927.1405646181065;6054.303755068047;6128.228138398679;6177.949748542758;6196.194494715748;5956.195913551615;6003.3996600339615;6012.5791194617705;6031.24609423822;6034.094885766995;6214.9067763984485;6234.688265586612;6249.843753906189;6277.435030847246;6291.622502649856;5628.549716022627;5641.4358564144895;5926.377730338252;5939.2575928009;5971.193888824953;5840.620359676607;5861.882762344644;5872.031114865999;5937.465628093492;5974.701264936823;5756.913646295393;5784.913226301524;5789.710514474175;5790.363060063474;5792.53659707214;5548.361938377138;5784.855378615568;5789.957807594674;5790.623609465371;5792.899349123653;5494.066008778597;5608.551315894637;5655.773769049357;5668.688222147822;5744.454276843693;5745.540356771365;5795.681237531976;5798.1302804579655;5802.071668533014;5805.3614102447855;5466.453354664502;5501.119820828648;5505.394406615349;5664.320281566073;5674.546036317167 21:05:32 INFO - PROCESS | 852 | |1;ext.html;580.9273840769904;596.0284735880514;627.6641996531855;649.3117295666591;651.9576227545206;33892.32215355695;44774.55225447753;44795.32807007893;44982.7750861246;44999.77500112499;47894.04211915768;48263.27605085926;48386.27420588694;48410.75794621022;48413.27380089302;8227.794305142359;8407.201315875012;8700.999999999984;8840.778980525474;8841.336899732514;10340.741481462986;10587.894121058767;10609.734756631107;10846.403447810368;10866.34801911884;10777.191710621735;10836.295640783324;10847.457627118652;10852.023317901387;10854.023137917626;10609.522571484264;10627.468626568641;10659.360438373684;10660.680179594625;10665.78668426631;10457.163426925828;10517.001769663739;10518.211134164969;10527.736806579896;10540.578376864916;42925;43187.35218971718;43238.35142472865;43269.35095973563;43315.78342108301;3492.912677183065;3550.130218096557;3595.1910820065536;3721.888343349704;4240.109576988836;32294.51558226605;32409.83795081033;32599.185020374443;32732;33582.49626255608;3904.7657140571655;3910.511186101737;3950.822213000422;3953.189596132786;4014.598540145991;367383;480488;483047;486241;490218;63918.68040659767;64285;64329.391765205306;64436.677816610616;64437.35562644407;35499.64500354963;35839.641603584154;67356;67698.66150669215;67748.6612566934;15659.2953317101;15695.293711782997;15698.76451853223;15705.450309239122;15705.607359816097;11489.712757181138;11651.359175245274;11655.30068195911;12221.816672749916;12349.629511114681;19067.379272761693;19779.23359956904;19868.60262794765;19917.60164796696;20008.2997095101;6962.825929351807;7197;7305.232950540223;7416.814579635445;7433.145188303414;1016.7763092119721;1067.3969207397795;1128.4132251229314;1133.1218305812897;1133.9546418143348;33121;33643.495347569806;33671;33889.491657625156;34222.14444638854;983.2723784399493;1146.7649131927935;1151.7638884028754;1167.3987896233446;1195.0738177912187;15741.527754167393;17517.474475765746;17557.561060973323;18330.90834545819;18525.81474185268;531568;534203;534508;535204;538228;60357.698211508665;60934.39065609287;60978.69510652418;60989.69505152446;61286;1312.960611181647;1357.429879450633;1379.6275005748591;1412.9788053179211;1422.6301161698034;30039.849800750857;34294.14264643404;34702.30595388129;34872.82563587166;35373.64626353807;51784.74107629438;57770.71114644568;58723.70638146782;58989.70505147447;63718.681406592674;472703;475640;475717;476180;478583;27757.30606734767;27874.58188127139;28001.71998279991;31560.26418547002;46029.07941841211;49256.507434925195;49353.75323123361;49688.75155624199;50260.74869625628;50540.24189637232;40163.79918100391;40900.79549602233;41462.79268603637;42614;42835.14329713326;41352.37971430371;41878;42142.57857421509;42225.36661950134;43098.353524696526;43283.567164329215;43285.78357108194;43933.02301396381;44360;44516.55483445124;35193.82403087968;37629;37648.24703505969;38641.61358386493;38902.41646375363;29090.272743180743;29512.409751805273;29780.851095744383;29867.55198672065;29884 21:05:32 INFO - PROCESS | 852 | |2;jquery.html;407.68811858927927;408.922304762095;416.77494153157295;422.91541691661666;431.54687578043047;16195;19069.90465047676;19775.5056123597;19847.404577862686;19949.900250498744;19602.215911363528;19956;20127.899360503212;20265.290714824947;20277;5295.4704529547125;5779.393163717812;5989.580729348925;6568.7700930467445;6615.801525954229;6502.382273683992;6538.476921846241;6691.93308066918;6713.798586042427;6723.46212303017;6576.309487503815;6624.039514270428;6625.271220165802;6625.60246385216;6628.5691430056895;6409.327020662833;6567.704453299613;6625.867482650344;6626.304238054983;6634.834129146786;5874.441928016831;5884.7940322088525;5888.29340479141;5891.675957822318;5895.734691938873;23727.76272237273;24072.398190045213;24081.397965050837;24165.637515437284;24377.14679986192;2512.1458704040715;2631.8947242110294;2632.4866651003063;2775.9167224983285;2937.456570534458;14995.32521036556;15029.699406011929;15088;15336.923315383463;15781.13203773792;1896.753422055138;1948.5323522354674;1983.2959299448632;1990.8606397552178;2011.3965810256864;82545;84719.99999999939;85060;85070;85820;10861.511231994578;10863.239573229956;10951.507182176822;11102.500387482583;11303.265287756269;15080.849191507945;15163.848361516244;15172.544823655307;15199.164045977577;15236.847631523542;7700.422468314787;7823.765287041284;8052.355811535063;8292.253697167163;8342.541160236246;7694.692212311556;7716.151223365426;7731.729389471341;7844.097928738154;7943.046834379911;6743.527953043338;6798.286179951034;6799.7280108796085;6818.659067046628;6937.410320122745;1885.820847019531;1990.6317331293758;2008.9296874609317;2014.8791072535694;2054.5207450635517;948.9478078705738;1058.9523471443804;1076.3488089705615;1111.6700451740426;1130.1128614038105;20087.5493647942;20668;20792.89603552003;20803.1678732852;21166.47083822917;991.3605724307781;1008.3395376028712;1032.0659802878406;1039.3400190878847;1089.515165751233;10679.946600266949;11751.236169648946;11764.470598823074;11791;11845.23006004607;388979;391034;391287;480934;495840;58341;68302;76516;87559.56220218986;88156.55921720351;997.9351342162736;1024.109025148126;1047.1413440978324;1060.7136073260176;1068.6206396729206;13699.726005479635;16546.42087526931;17205.537529309648;18249.90875045616;18515.444536663923;28610.403872766503;32586.674133258362;35496;38777.806110969264;42313.78843105765;57812;58130.12804807847;58812.411875880694;59021.704891476984;60137;7282.745103921337;7564.848703025798;7579.0905091387185;7581.203973582695;7683.0780306363595;13204.141730787467;13472.326383680973;13517.932410337886;13561.93219033938;13754.105983111065;11724.765504689687;11783.469743861375;11786.410679466164;12107.818382724443;12336.938315308365;11433.314001159957;11790.351530665896;11978.520859165885;12004.279743215086;12074.215176013882;11698.649040528799;12033.45849436795;12039.217450866015;12064.819027714415;12324.630261092181;7369.926300736924;7415.592142432002;7586.582737949245;7896.407769417202;8656.350773691873;11875.287482751062;12203.877961220274;12327.445264962918;12767;12798.16811907223 21:05:32 INFO - PROCESS | 852 | |3;mootools.html;1463.9853601463985;1501.932413041413;1622.756586512024;1736.4009416751217;1780.6527727093214;7891.881621775671;8401.53791541465;8405.411621186504;8406.411551191411;8412.284955778758;7414.814629634262;7580.204078571739;8060.113387527367;8293.33653307734;8341.249287564118;2322.129201549419;2346.3664810501155;2347.096367898363;2350.647402889572;2353;2372.0511795281855;2404.5671779079757;2426.454047839231;2426.987865060681;2428.0651948999675;2403.194929698553;2405.0980882169188;2411.5297516984197;2442.2306973303353;2473.468204336067;2378.452955820154;2402.243293362585;2412.975870241293;2418.069043418279;2426.0417135231573;2396.9520609587885;2411.1078900806638;2412.6622272881636;2414.1912459326145;2419.63705444183;8583;8585.699500517452;8627.870581941275;8633.568321583958;8644.654213831502;5340.599455040888;5472.863178420532;5478.45215478453;5484.7531861066345;5492.368377636583;3426.8971930842113;3429.416999110157;3549.1304630365466;3626.8005259710703;3641.8543258269638;1066.211003857148;1081.3133660125798;1096.1614365010773;1129.5989923577094;1179.3218899132946;11812.822807657805;11884.584039558575;11930.880691193064;11948.163628546004;11959.760804783942;4722.386089808303;4765.11845308619;4838.516148385203;4870.780814863339;4939.160342741742;9925.900740992498;9937.453440060866;9938.45338506389;9942.502874856229;9945.552450139761;5463.071277882769;5521.365043020104;5530;5530.695811730394;5555.722213889289;4427.63121729873;4481.462224533012;4934.062528119646;4988.251762235694;5078.847634570969;4015.0966032642423;4101.815418306183;4154.833806647761;4172.4993000840095;4203.096334288142;1355.3833005982253;1377;1378.2832926877968;1393.853645367242;1398.3847107272768;916.5966974531185;926.666400095965;927.8793756811572;942.222666300305;946.370663508759;5697;5778.711064446761;5801.837998290942;6058.848528786727;6079.574429789961;457.28434999226107;460.0982075132777;461.9769011549409;467.06120697397796;472.36702818223745;3990.1114199227745;4037.0916543777416;4059.837606495766;4063.39049142631;4092.6930480214105;9983.60065597368;9994.750131246632;10059.899401006043;10068.798624027479;10071.748206294902;9960.053794889474;9980.351277166961;9985.800283994426;9992.550335234931;9999.200063994864;7744.954431151722;7807.180246074194;7824.295813376823;7833.060032795987;7839.25527074927;5450.754716037709;5584.664920104807;5699.202111704281;5717.571182161438;5837.153612726216;9166;9185.311101667268;9200;9226.815463690822;9284.02517735628;9058.6447523643;9237.353385262966;9272.536373181449;9327.58025888823;9334.973152953035;7079.575225486487;7195.424366050599;7252.202257751537;7264.67308971087;7344.48588598793;8311.293540049164;8371.121032291521;8377.70678026266;8383.245507904317;8391.202835730595;7003.26465721092;7008.474364422791;7203.351698347174;7365.926340736738;7585.734499292498;7129;7339.889901651372;7366.373858222111;7375.8156046099275;7557;6867.278935711878;6988.685509151998;6992.79021629352;6994.615296158557;6997.090378250795;4981.336143266909;4982.950170498249;5063.3417655704525;5082.313887625123;5096.439391666988;4931;4934.827281045146;5098.898022039612;5104.310918026019;5128.128218202989 21:05:32 INFO - PROCESS | 852 | |4;prototype.html;351.9401701710709;352.88002079293045;360.48450715476866;365.74580666436805;371.47807330700357;5122.975404919012;5275.73621318934;5305.575553955684;5321.600879934011;5334.253204551361;5050.797968081272;5135.690398948263;5142.640015198937;5191.143461328886;5206.817761378353;4144.875653730385;4159.209750147477;4161.895952601179;4170.374443833419;4176.102138040321;4116.094459218967;4156.355764856452;4158.671144159265;4165.291900376928;4172.228137794517;4156.688248381369;4163.958360416403;4170.687198460112;4172.812223449937;4173.227952828721;4154.169166166764;4172.895677608069;4182.494302051259;4191.832326706928;4207.1165055338415;3701.222743223926;3798.0694729791103;3801.904952376185;3806.543214814212;3807.9428808567895;5120.92318615221;5144.4083930348115;5148.871278218037;5152.793888244466;5158.664686795346;4838.782254798507;4853.490383509716;4853.611711063107;4856.927146092811;4867.780949857265;5367.838964831061;5536.363318218416;5548.944510554883;5549.639273447213;5558.499735023867;4184.539700632928;4194;4195.056112374722;4221.978890105561;4227.619514243702;5723.885522289573;5737.741801618896;5751.25233719618;5758.913616295759;5761.481466667978;4107.568705285962;4245.702800803976;4247.32042873145;4259.190753756776;4325.437693099877;4303.289957157097;4312.460942382202;4331.133773245364;4332.848350307724;4333.678228140385;4794.520547945178;4803.366855269225;4819.7108173509705;4826.855194344175;4848.975755121272;5336.1195402758885;5555.944440555542;5565.860853478614;5641.464060914206;5645.604807663424;1388.438007241853;1406.9577912662637;1427.978580321296;1449.4564538298139;1461.8684318411395;1006.4615430744517;1027.3681685763202;1036.5231993283023;1051.500537244818;1052.0689190066846;5166.250893620404;5166.405863325691;5168.759497720595;5179.533841954242;5179.870503237449;5427.891442171134;5428.5385742211565;5438.673679579238;5446.564274858002;5453.182022696627;5153.613478989091;5160.561916751591;5196.948030519722;5226.268322434862;5405.864853378697;2896.391757730858;2920.5619157126603;2931.3551018775834;2931.648202215748;2940.5442156465783;5670.858228544237;5716.742746576414;5741.913871291934;5749;5803.709814509258;5465.770201704664;5526.811735476892;5561.221428999862;5587.916181257285;5598.7045311422125;5663.292088488856;5710.457506536873;5717.256756621613;5722.856928576819;5732.340780810094;5340.706261155518;5489.807856724996;5509.641873278224;5510.641808282448;5602.761418074114;5358.276632654698;5359.732013399236;5364.731763411735;5372.382176049804;5404.891902162013;5650.29371328584;5665.546756259571;5682.460166284196;5690.459406356389;5733.799317023884;3826.368649172967;3995.2409042281874;4002.45966794479;4013.157236980267;4064.4106604542767;5428.669975855941;5449.100898351728;5474.562035037267;5486.862828429162;5574.526165275997;5410.269613602113;5420.918686219631;5440.694233384039;5448.318960129984;5467.043267428264;5474.42518535564;5478.369987451494;5538.224648549287;5568.549838071236;5590.413006634245;5263.5525980292105;5451.20957461158;5471.781128754806;5493.807716729895;5562.388137304974;5502.706863886903;5526.55787536988;5526.778928842801;5536.2249285100925;5543;5271.894562108813;5429.67421954684;5443.319585051869;5457.508824205841;5471.37079235893 21:05:32 INFO - PROCESS | 852 | |5;yui.html;638.2213699286868;646.1664452855815;655.3773914780959;669.8961660942556;682.7064362324202;12562.057845661579;12917.35413229337;12956.222626642408;12958.222506649608;12976.026797990142;12240.143189976705;12364.690882727937;12369.319687417212;12369.505219791197;12383.69040773981;714.5748279773527;732.9267073292655;809.5385630190793;822.9917700823005;849.0957130655862;846.2933450568783;848.0840692052599;849.0829903704016;849.2441726863066;850.1371108325055;893.13366034946;894.4767311123001;894.7584152278881;894.7628878347243;895.0110128308223;743.7248218159289;758.6055251269337;873.9082396348388;885.0397318908991;896.44420459315;634.0267689097213;634.6921742954663;635.3709827270968;635.71710588788;636.8885445047098;11598.652040438801;11675.182737208399;11689.532418703242;11729.941350293278;11821.408929553489;12554.81167782484;12603.873961260362;12791.936040319739;12849.164804287784;12938.87061129386;9988.250881183867;10000.849987250198;10038.64864729731;10243.07812296897;10265.486725663686;3003;3009.774266929989;3017.9547306790414;3033.848307584612;3058.082575227445;56851.999999999585;62158.37841621616;62570.68714656443;63662;64773;9960.203183745283;10467.371957682564;10589.311694739818;10618.150547956146;10746.677599671866;18781.248750049846;18880.24479020851;18929.526761831065;18941.147648355858;18952.336668216547;7216.963915180496;7245.130584329809;7351.8162045949275;7479.551226926402;7507.549547027196;3829.349010668193;3954.0905591714068;3959.346707793182;3962.306596345628;3969.702272329587;3152.3537674776617;3272.969014760343;3274.279658475132;3276.574045374086;3277.410066188109;564.8700798816213;611.7430679114693;612.1491127333011;613.2671457608204;639.9936000639934;486.9756512174377;528.3422139436426;553.5267346418754;567.9403662615448;576.2105914896534;7466.2509867401795;7495.287947644965;7605.885911711329;7833.960830195927;8031.678732850737;543.9265699130646;546.7594258526316;560.6047736345866;566.8554518597731;574.5719439017959;3745.831437585315;3758.9248215035545;3804.9429258561145;3818.236352729465;3897.337452633059;87973.56013219892;88237.55881220553;89238.10761892427;90493.54753226192;90666.54666726624;64247.678761606825;77678.22321776823;78069;78971.21028789639;79867;69179.3082069183;70175.2982470179;70312;71404;73462.26537734662;7110.85778284421;7261.963690181516;7352.11774587053;7481.139668938142;7494.668022085317;47019.52980470152;47123.52876471329;47138.76430617825;48230.5176948226;49150.5084949146;62985.68507157435;64303.35696642974;65104.67447662731;65214.34785652083;67801.66099169472;10302.175825934057;10321.74195645115;10574.41840698769;10640.134117670326;10677.305975111592;10836.837447438136;10870.456477176267;10966.835497467704;11010.559577617127;11212;9775.75560610962;11032.117430605693;11202.327860328407;11440.370779607201;12058.095642826998;11552.133589980953;11593.884061159617;11633.185677002528;11691.766164676828;11861.991730702643;11080.61217857371;11176.944115279372;11304.717382065513;11460.19778615489;11479.713007174887;9308.394954327947;9480.383775054599;9491.288153388385;9631.9036809631;10160.441175735405;9135.451872887383;9462.384944978554;9598.376105553116;9612.807743845224;9678.225741940769 21:05:32 INFO - PROCESS | 852 | __end_tp_report 21:05:32 INFO - PROCESS | 852 | __start_cc_report 21:05:32 INFO - PROCESS | 852 | _x_x_mozilla_cycle_collect,966 21:05:32 INFO - PROCESS | 852 | __end_cc_report 21:05:32 INFO - PROCESS | 852 | __startTimestamp1481864732795__endTimestamp 21:05:32 INFO - PROCESS | 852 | 21:05:32 INFO - PROCESS | 852 | ------- Summary: start ------- 21:05:32 INFO - PROCESS | 852 | Number of tests: 6 21:05:32 INFO - PROCESS | 852 | 21:05:32 INFO - PROCESS | 852 | [#0] dojo.html Cycles:165 Average:5475.25 Median:5674.55 stddev:619.23 (10.9%) stddev-sans-first:593.94 21:05:32 INFO - PROCESS | 852 | Values: 3161.8 3167.2 3167.4 3184.5 3199.1 5323.0 5376.3 5404.0 5425.2 5447.3 5449.0 5472.9 5474.6 5477.6 5488.0 4941.6 4954.8 5022.4 5022.6 5035.0 4965.2 4993.2 5057.9 5065.8 5086.4 4954.3 4980.7 5020.4 5061.5 5073.5 4997.4 5039.1 5040.1 5090.7 5133.6 4986.3 5014.7 5052.7 5068.0 5071.6 5304.4 5369.0 5391.4 5393.1 5429.4 5818.2 5821.7 5892.9 5924.2 5933.3 5731.1 5915.8 5924.3 5959.3 5974.0 5394.6 5458.9 5478.9 5491.7 5568.4 6019.2 6044.1 6049.8 6053.7 6068.0 5678.1 5814.4 5820.9 5821.1 5827.3 5749.2 5785.6 5792.6 5800.8 5894.6 5825.0 5838.3 5842.4 5848.9 5882.0 5782.2 5831.7 5835.9 5843.4 5851.6 4490.1 4495.1 4551.7 4566.2 4573.9 4029.5 4052.9 4070.6 4080.0 4089.8 5622.4 5632.8 5634.5 5645.1 5674.9 5747.2 5789.9 5857.4 5910.9 5914.1 5664.2 5665.1 5675.4 5688.3 5702.5 5162.5 5176.8 5180.8 5183.1 5230.1 5927.1 6054.3 6128.2 6177.9 6196.2 5956.2 6003.4 6012.6 6031.2 6034.1 6214.9 6234.7 6249.8 6277.4 6291.6 5628.5 5641.4 5926.4 5939.3 5971.2 5840.6 5861.9 5872.0 5937.5 5974.7 5756.9 5784.9 5789.7 5790.4 5792.5 5548.4 5784.9 5790.0 5790.6 5792.9 5494.1 5608.6 5655.8 5668.7 5744.5 5745.5 5795.7 5798.1 5802.1 5805.4 5466.5 5501.1 5505.4 5664.3 5674.5 21:05:32 INFO - PROCESS | 852 | 21:05:32 INFO - PROCESS | 852 | [#1] ext.html Cycles:180 Average:65465.82 Median:21403.59 stddev:130543.85 (609.9%) stddev-sans-first:130819.16 21:05:32 INFO - PROCESS | 852 | Values: 580.9 596.0 627.7 649.3 652.0 33892.3 44774.6 44795.3 44982.8 44999.8 47894.0 48263.3 48386.3 48410.8 48413.3 8227.8 8407.2 8701.0 8840.8 8841.3 10340.7 10587.9 10609.7 10846.4 10866.3 10777.2 10836.3 10847.5 10852.0 10854.0 10609.5 10627.5 10659.4 10660.7 10665.8 10457.2 10517.0 10518.2 10527.7 10540.6 42925.0 43187.4 43238.4 43269.4 43315.8 3492.9 3550.1 3595.2 3721.9 4240.1 32294.5 32409.8 32599.2 32732.0 33582.5 3904.8 3910.5 3950.8 3953.2 4014.6 367383.0 480488.0 483047.0 486241.0 490218.0 63918.7 64285.0 64329.4 64436.7 64437.4 35499.6 35839.6 67356.0 67698.7 67748.7 15659.3 15695.3 15698.8 15705.5 15705.6 11489.7 11651.4 11655.3 12221.8 12349.6 19067.4 19779.2 19868.6 19917.6 20008.3 6962.8 7197.0 7305.2 7416.8 7433.1 1016.8 1067.4 1128.4 1133.1 1134.0 33121.0 33643.5 33671.0 33889.5 34222.1 983.3 1146.8 1151.8 1167.4 1195.1 15741.5 17517.5 17557.6 18330.9 18525.8 531568.0 534203.0 534508.0 535204.0 538228.0 60357.7 60934.4 60978.7 60989.7 61286.0 1313.0 1357.4 1379.6 1413.0 1422.6 30039.8 34294.1 34702.3 34872.8 35373.6 51784.7 57770.7 58723.7 58989.7 63718.7 472703.0 475640.0 475717.0 476180.0 478583.0 27757.3 27874.6 28001.7 31560.3 46029.1 49256.5 49353.8 49688.8 50260.7 50540.2 40163.8 40900.8 41462.8 42614.0 42835.1 41352.4 41878.0 42142.6 42225.4 43098.4 43283.6 43285.8 43933.0 44360.0 44516.6 35193.8 37629.0 37648.2 38641.6 38902.4 29090.3 29512.4 29780.9 29867.6 29884.0 21:05:32 INFO - PROCESS | 852 | 21:05:32 INFO - PROCESS | 852 | [#2] jquery.html Cycles:180 Average:27213.61 Median:24271.39 stddev:71313.86 (293.8%) stddev-sans-first:71485.51 21:05:32 INFO - PROCESS | 852 | Values: 407.7 408.9 416.8 422.9 431.5 16195.0 19069.9 19775.5 19847.4 19949.9 19602.2 19956.0 20127.9 20265.3 20277.0 5295.5 5779.4 5989.6 6568.8 6615.8 6502.4 6538.5 6691.9 6713.8 6723.5 6576.3 6624.0 6625.3 6625.6 6628.6 6409.3 6567.7 6625.9 6626.3 6634.8 5874.4 5884.8 5888.3 5891.7 5895.7 23727.8 24072.4 24081.4 24165.6 24377.1 2512.1 2631.9 2632.5 2775.9 2937.5 14995.3 15029.7 15088.0 15336.9 15781.1 1896.8 1948.5 1983.3 1990.9 2011.4 82545.0 84720.0 85060.0 85070.0 85820.0 10861.5 10863.2 10951.5 11102.5 11303.3 15080.8 15163.8 15172.5 15199.2 15236.8 7700.4 7823.8 8052.4 8292.3 8342.5 7694.7 7716.2 7731.7 7844.1 7943.0 6743.5 6798.3 6799.7 6818.7 6937.4 1885.8 1990.6 2008.9 2014.9 2054.5 948.9 1059.0 1076.3 1111.7 1130.1 20087.5 20668.0 20792.9 20803.2 21166.5 991.4 1008.3 1032.1 1039.3 1089.5 10679.9 11751.2 11764.5 11791.0 11845.2 388979.0 391034.0 391287.0 480934.0 495840.0 58341.0 68302.0 76516.0 87559.6 88156.6 997.9 1024.1 1047.1 1060.7 1068.6 13699.7 16546.4 17205.5 18249.9 18515.4 28610.4 32586.7 35496.0 38777.8 42313.8 57812.0 58130.1 58812.4 59021.7 60137.0 7282.7 7564.8 7579.1 7581.2 7683.1 13204.1 13472.3 13517.9 13561.9 13754.1 11724.8 11783.5 11786.4 12107.8 12336.9 11433.3 11790.4 11978.5 12004.3 12074.2 11698.6 12033.5 12039.2 12064.8 12324.6 7369.9 7415.6 7586.6 7896.4 8656.4 11875.3 12203.9 12327.4 12767.0 12798.2 21:05:32 INFO - PROCESS | 852 | 21:05:32 INFO - PROCESS | 852 | [#3] mootools.html Cycles:180 Average:5599.04 Median:5467.97 stddev:3049.63 (55.8%) stddev-sans-first:3042.35 21:05:32 INFO - PROCESS | 852 | Values: 1464.0 1501.9 1622.8 1736.4 1780.7 7891.9 8401.5 8405.4 8406.4 8412.3 7414.8 7580.2 8060.1 8293.3 8341.2 2322.1 2346.4 2347.1 2350.6 2353.0 2372.1 2404.6 2426.5 2427.0 2428.1 2403.2 2405.1 2411.5 2442.2 2473.5 2378.5 2402.2 2413.0 2418.1 2426.0 2397.0 2411.1 2412.7 2414.2 2419.6 8583.0 8585.7 8627.9 8633.6 8644.7 5340.6 5472.9 5478.5 5484.8 5492.4 3426.9 3429.4 3549.1 3626.8 3641.9 1066.2 1081.3 1096.2 1129.6 1179.3 11812.8 11884.6 11930.9 11948.2 11959.8 4722.4 4765.1 4838.5 4870.8 4939.2 9925.9 9937.5 9938.5 9942.5 9945.6 5463.1 5521.4 5530.0 5530.7 5555.7 4427.6 4481.5 4934.1 4988.3 5078.8 4015.1 4101.8 4154.8 4172.5 4203.1 1355.4 1377.0 1378.3 1393.9 1398.4 916.6 926.7 927.9 942.2 946.4 5697.0 5778.7 5801.8 6058.8 6079.6 457.3 460.1 462.0 467.1 472.4 3990.1 4037.1 4059.8 4063.4 4092.7 9983.6 9994.8 10059.9 10068.8 10071.7 9960.1 9980.4 9985.8 9992.6 9999.2 7745.0 7807.2 7824.3 7833.1 7839.3 5450.8 5584.7 5699.2 5717.6 5837.2 9166.0 9185.3 9200.0 9226.8 9284.0 9058.6 9237.4 9272.5 9327.6 9335.0 7079.6 7195.4 7252.2 7264.7 7344.5 8311.3 8371.1 8377.7 8383.2 8391.2 7003.3 7008.5 7203.4 7365.9 7585.7 7129.0 7339.9 7366.4 7375.8 7557.0 6867.3 6988.7 6992.8 6994.6 6997.1 4981.3 4983.0 5063.3 5082.3 5096.4 4931.0 4934.8 5098.9 5104.3 5128.1 21:05:32 INFO - PROCESS | 852 | 21:05:32 INFO - PROCESS | 852 | [#4] prototype.html Cycles:180 Average:4644.56 Median:5185.51 stddev:1315.49 (25.4%) stddev-sans-first:1279.11 21:05:32 INFO - PROCESS | 852 | Values: 351.9 352.9 360.5 365.7 371.5 5123.0 5275.7 5305.6 5321.6 5334.3 5050.8 5135.7 5142.6 5191.1 5206.8 4144.9 4159.2 4161.9 4170.4 4176.1 4116.1 4156.4 4158.7 4165.3 4172.2 4156.7 4164.0 4170.7 4172.8 4173.2 4154.2 4172.9 4182.5 4191.8 4207.1 3701.2 3798.1 3801.9 3806.5 3807.9 5120.9 5144.4 5148.9 5152.8 5158.7 4838.8 4853.5 4853.6 4856.9 4867.8 5367.8 5536.4 5548.9 5549.6 5558.5 4184.5 4194.0 4195.1 4222.0 4227.6 5723.9 5737.7 5751.3 5758.9 5761.5 4107.6 4245.7 4247.3 4259.2 4325.4 4303.3 4312.5 4331.1 4332.8 4333.7 4794.5 4803.4 4819.7 4826.9 4849.0 5336.1 5555.9 5565.9 5641.5 5645.6 1388.4 1407.0 1428.0 1449.5 1461.9 1006.5 1027.4 1036.5 1051.5 1052.1 5166.3 5166.4 5168.8 5179.5 5179.9 5427.9 5428.5 5438.7 5446.6 5453.2 5153.6 5160.6 5196.9 5226.3 5405.9 2896.4 2920.6 2931.4 2931.6 2940.5 5670.9 5716.7 5741.9 5749.0 5803.7 5465.8 5526.8 5561.2 5587.9 5598.7 5663.3 5710.5 5717.3 5722.9 5732.3 5340.7 5489.8 5509.6 5510.6 5602.8 5358.3 5359.7 5364.7 5372.4 5404.9 5650.3 5665.5 5682.5 5690.5 5733.8 3826.4 3995.2 4002.5 4013.2 4064.4 5428.7 5449.1 5474.6 5486.9 5574.5 5410.3 5420.9 5440.7 5448.3 5467.0 5474.4 5478.4 5538.2 5568.5 5590.4 5263.6 5451.2 5471.8 5493.8 5562.4 5502.7 5526.6 5526.8 5536.2 5543.0 5271.9 5429.7 5443.3 5457.5 5471.4 21:05:32 INFO - PROCESS | 852 | 21:05:32 INFO - PROCESS | 852 | [#5] yui.html Cycles:180 Average:17149.79 Median:567.40 stddev:24089.23 (4245.6%) stddev-sans-first:24124.90 21:05:32 INFO - PROCESS | 852 | Values: 638.2 646.2 655.4 669.9 682.7 12562.1 12917.4 12956.2 12958.2 12976.0 12240.1 12364.7 12369.3 12369.5 12383.7 714.6 732.9 809.5 823.0 849.1 846.3 848.1 849.1 849.2 850.1 893.1 894.5 894.8 894.8 895.0 743.7 758.6 873.9 885.0 896.4 634.0 634.7 635.4 635.7 636.9 11598.7 11675.2 11689.5 11729.9 11821.4 12554.8 12603.9 12791.9 12849.2 12938.9 9988.3 10000.8 10038.6 10243.1 10265.5 3003.0 3009.8 3018.0 3033.8 3058.1 56852.0 62158.4 62570.7 63662.0 64773.0 9960.2 10467.4 10589.3 10618.2 10746.7 18781.2 18880.2 18929.5 18941.1 18952.3 7217.0 7245.1 7351.8 7479.6 7507.5 3829.3 3954.1 3959.3 3962.3 3969.7 3152.4 3273.0 3274.3 3276.6 3277.4 564.9 611.7 612.1 613.3 640.0 487.0 528.3 553.5 567.9 576.2 7466.3 7495.3 7605.9 7834.0 8031.7 543.9 546.8 560.6 566.9 574.6 3745.8 3758.9 3804.9 3818.2 3897.3 87973.6 88237.6 89238.1 90493.5 90666.5 64247.7 77678.2 78069.0 78971.2 79867.0 69179.3 70175.3 70312.0 71404.0 73462.3 7110.9 7262.0 7352.1 7481.1 7494.7 47019.5 47123.5 47138.8 48230.5 49150.5 62985.7 64303.4 65104.7 65214.3 67801.7 10302.2 10321.7 10574.4 10640.1 10677.3 10836.8 10870.5 10966.8 11010.6 11212.0 9775.8 11032.1 11202.3 11440.4 12058.1 11552.1 11593.9 11633.2 11691.8 11862.0 11080.6 11176.9 11304.7 11460.2 11479.7 9308.4 9480.4 9491.3 9631.9 10160.4 9135.5 9462.4 9598.4 9612.8 9678.2 21:05:32 INFO - PROCESS | 852 | -------- Summary: end -------- 21:05:32 INFO - PROCESS | 852 | 21:05:33 INFO - TEST-INFO | 852: exit 0 21:05:33 INFO - TEST-OK | dromaeo_css | took 1115470ms 21:05:33 INFO - TEST-START | kraken 21:05:33 INFO - operating with platform_type : linux_ 21:05:33 INFO - Initialising browser for kraken test... 21:05:33 INFO - TEST-INFO | started process 1248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX8Wcb1/profile http://localhost:34810/getInfo.html) 21:05:37 INFO - PROCESS | 1248 | __metrics Screen width/height:1600/1200 21:05:37 INFO - PROCESS | 1248 | colorDepth:24 21:05:37 INFO - PROCESS | 1248 | Browser inner width/height: 1024/697 21:05:37 INFO - PROCESS | 1248 | __metrics 21:05:38 INFO - PROCESS | 1248 | 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" 21:05:38 INFO - PROCESS | 1248 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:05:38 INFO - PROCESS | 1248 | console.error: PushService: 21:05:38 INFO - PROCESS | 1248 | stateChangeProcessEnqueue: Error transitioning state 21:05:38 INFO - PROCESS | 1248 | UnknownError 21:05:39 INFO - TEST-INFO | 1248: exit 0 21:05:39 INFO - Browser initialized. 21:05:39 INFO - Running cycle 1/1 for kraken test... 21:05:39 INFO - TEST-INFO | started process 1340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX8Wcb1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:05:51 INFO - PROCESS | 1340 | RSS: Main: 144510976 21:05:51 INFO - PROCESS | 1340 | 21:05:53 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34810/tests/kraken/driver.html?testName=audio-beat-detection) 21:05:54 INFO - PROCESS | 1340 | RSS: Main: 186064896 21:05:54 INFO - PROCESS | 1340 | 21:05:57 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34810/tests/kraken/driver.html?testName=audio-dft) 21:05:57 INFO - PROCESS | 1340 | RSS: Main: 174854144 21:05:57 INFO - PROCESS | 1340 | 21:06:00 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34810/tests/kraken/driver.html?testName=audio-fft) 21:06:01 INFO - PROCESS | 1340 | RSS: Main: 266383360 21:06:01 INFO - PROCESS | 1340 | 21:06:03 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34810/tests/kraken/driver.html?testName=audio-oscillator) 21:06:03 INFO - PROCESS | 1340 | RSS: Main: 172605440 21:06:03 INFO - PROCESS | 1340 | 21:06:05 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:06:06 INFO - PROCESS | 1340 | RSS: Main: 174800896 21:06:06 INFO - PROCESS | 1340 | 21:06:09 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34810/tests/kraken/driver.html?testName=imaging-darkroom) 21:06:10 INFO - PROCESS | 1340 | RSS: Main: 213970944 21:06:10 INFO - PROCESS | 1340 | 21:06:13 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34810/tests/kraken/driver.html?testName=imaging-desaturate) 21:06:13 INFO - PROCESS | 1340 | RSS: Main: 213225472 21:06:13 INFO - PROCESS | 1340 | 21:06:16 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34810/tests/kraken/driver.html?testName=json-parse-financial) 21:06:17 INFO - PROCESS | 1340 | RSS: Main: 211775488 21:06:17 INFO - PROCESS | 1340 | 21:06:18 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:06:19 INFO - PROCESS | 1340 | RSS: Main: 173989888 21:06:19 INFO - PROCESS | 1340 | 21:06:21 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34810/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:06:21 INFO - PROCESS | 1340 | RSS: Main: 180756480 21:06:21 INFO - PROCESS | 1340 | 21:06:23 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:06:24 INFO - PROCESS | 1340 | RSS: Main: 190107648 21:06:24 INFO - PROCESS | 1340 | 21:06:26 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:06:27 INFO - PROCESS | 1340 | RSS: Main: 197988352 21:06:27 INFO - PROCESS | 1340 | 21:06:30 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:06:30 INFO - PROCESS | 1340 | RSS: Main: 195076096 21:06:30 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | Cycle 1(1): loaded http://localhost:34810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34810/tests/kraken/driver.html?testName=ai-astar) 21:06:32 INFO - PROCESS | 1340 | RSS: Main: 246026240 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | __start_tp_report 21:06:32 INFO - PROCESS | 1340 | _x_x_mozilla_page_load 21:06:32 INFO - PROCESS | 1340 | _x_x_mozilla_page_load_details 21:06:32 INFO - PROCESS | 1340 | |i|pagename|runs| 21:06:32 INFO - PROCESS | 1340 | |0;ai-astar;105;112;110;110;111;113;110;112;112;111 21:06:32 INFO - PROCESS | 1340 | |1;audio-beat-detection;152;119;118;164;120;117;118;118;159;120 21:06:32 INFO - PROCESS | 1340 | |2;audio-dft;160;161;159;159;164;160;159;158;159;160 21:06:32 INFO - PROCESS | 1340 | |3;audio-fft;74;75;75;106;76;76;76;75;111;75 21:06:32 INFO - PROCESS | 1340 | |4;audio-oscillator;81;82;123;81;82;83;105;81;82;108 21:06:32 INFO - PROCESS | 1340 | |5;imaging-gaussian-blur;116;117;118;117;117;117;117;117;116;117 21:06:32 INFO - PROCESS | 1340 | |6;imaging-darkroom;146;145;146;146;146;145;146;145;146;145 21:06:32 INFO - PROCESS | 1340 | |7;imaging-desaturate;90;85;84;84;85;85;85;85;85;84 21:06:32 INFO - PROCESS | 1340 | |8;json-parse-financial;49;50;51;50;50;50;50;50;49;51 21:06:32 INFO - PROCESS | 1340 | |9;json-stringify-tinderbox;59;61;60;62;61;60;61;61;61;61 21:06:32 INFO - PROCESS | 1340 | |10;stanford-crypto-aes;74;75;80;76;75;79;79;75;75;73 21:06:32 INFO - PROCESS | 1340 | |11;stanford-crypto-ccm;122;131;121;123;122;131;126;131;172;135 21:06:32 INFO - PROCESS | 1340 | |12;stanford-crypto-pbkdf2;153;154;152;155;157;157;155;154;153;153 21:06:32 INFO - PROCESS | 1340 | |13;stanford-crypto-sha256-iterative;63;66;64;63;62;67;63;65;62;61 21:06:32 INFO - PROCESS | 1340 | __end_tp_report 21:06:32 INFO - PROCESS | 1340 | __start_cc_report 21:06:32 INFO - PROCESS | 1340 | _x_x_mozilla_cycle_collect,1637 21:06:32 INFO - PROCESS | 1340 | __end_cc_report 21:06:32 INFO - PROCESS | 1340 | __startTimestamp1481864792626__endTimestamp 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | ------- Summary: start ------- 21:06:32 INFO - PROCESS | 1340 | Number of tests: 14 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.22 (2.0%) stddev-sans-first:1.09 21:06:32 INFO - PROCESS | 1340 | Values: 105.0 112.0 110.0 110.0 111.0 113.0 110.0 112.0 112.0 111.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:120.00 stddev:19.44 (16.2%) stddev-sans-first:19.00 21:06:32 INFO - PROCESS | 1340 | Values: 152.0 119.0 118.0 164.0 120.0 117.0 118.0 118.0 159.0 120.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.66 (1.0%) stddev-sans-first:1.76 21:06:32 INFO - PROCESS | 1340 | Values: 160.0 161.0 159.0 159.0 164.0 160.0 159.0 158.0 159.0 160.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:14.08 (18.8%) stddev-sans-first:14.64 21:06:32 INFO - PROCESS | 1340 | Values: 74.0 75.0 75.0 106.0 76.0 76.0 76.0 75.0 111.0 75.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:81.50 stddev:15.33 (18.8%) stddev-sans-first:15.85 21:06:32 INFO - PROCESS | 1340 | Values: 81.0 82.0 123.0 81.0 82.0 83.0 105.0 81.0 82.0 108.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 21:06:32 INFO - PROCESS | 1340 | Values: 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:06:32 INFO - PROCESS | 1340 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.75 (2.1%) stddev-sans-first:0.50 21:06:32 INFO - PROCESS | 1340 | Values: 90.0 85.0 84.0 84.0 85.0 85.0 85.0 85.0 85.0 84.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 21:06:32 INFO - PROCESS | 1340 | Values: 49.0 50.0 51.0 50.0 50.0 50.0 50.0 50.0 49.0 51.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 21:06:32 INFO - PROCESS | 1340 | Values: 59.0 61.0 60.0 62.0 61.0 60.0 61.0 61.0 61.0 61.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:75.50 stddev:2.38 (3.1%) stddev-sans-first:2.40 21:06:32 INFO - PROCESS | 1340 | Values: 74.0 75.0 80.0 76.0 75.0 79.0 79.0 75.0 75.0 73.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:131.00 stddev:15.08 (11.5%) stddev-sans-first:15.61 21:06:32 INFO - PROCESS | 1340 | Values: 122.0 131.0 121.0 123.0 122.0 131.0 126.0 131.0 172.0 135.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:154.50 stddev:1.70 (1.1%) stddev-sans-first:1.74 21:06:32 INFO - PROCESS | 1340 | Values: 153.0 154.0 152.0 155.0 157.0 157.0 155.0 154.0 153.0 153.0 21:06:32 INFO - PROCESS | 1340 | 21:06:32 INFO - PROCESS | 1340 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:1.90 (3.0%) stddev-sans-first:2.00 21:06:32 INFO - PROCESS | 1340 | Values: 63.0 66.0 64.0 63.0 62.0 67.0 63.0 65.0 62.0 61.0 21:06:32 INFO - PROCESS | 1340 | -------- Summary: end -------- 21:06:32 INFO - PROCESS | 1340 | 21:06:33 INFO - TEST-INFO | 1340: exit 0 21:06:33 INFO - TEST-OK | kraken | took 60130ms 21:06:33 INFO - SUITE-END | took 1175s 21:06:33 INFO - Completed test suite (00:19:35) 21:06:33 INFO - javascript benchmark 21:06:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.8102913825173, 3167.1607024138602, 3167.4456970030246, 3184.538241954915, 3199.1202419334695, 5322.973385133074, 5376.301080859487, 5404.0, 5425.213344065108, 5447.264619276397, 5449.0, 5472.91790623141, 5474.644148130379, 5477.616566840323, 5488.012157811602, 4941.62937779667, 4954.826581069663, 5022.372203474566, 5022.623303252252, 5035.043341765071, 4965.205567109263, 4993.226049962243, 5057.924131138036, 5065.848024559269, 5086.415062267831, 4954.3063971044085, 4980.6762560433635, 5020.447750747415, 5061.54446099851, 5073.492650734934, 4997.350344455216, 5039.143345631252, 5040.092783299005, 5090.694558326512, 5133.640645154841, 4986.252062190664, 5014.6991180529285, 5052.696838189684, 5067.974660126676, 5071.594272458195, 5304.443033481468, 5368.973155134238, 5391.433899440581, 5393.083175860074, 5429.4299098594865, 5818.2145410369485, 5821.708914554298, 5892.882142357172, 5924.200232968537, 5933.258342707161, 5731.083026715747, 5915.792947246869, 5924.318703349127, 5959.344472108065, 5974.044152935553, 5394.595405344576, 5458.91811622822, 5478.890422191534, 5491.670499770026, 5568.359638641527, 6019.157317975487, 6044.063170208625, 6049.8487537811025, 6053.697315134225, 6067.969660151671, 5678.14827775837, 5814.418558144236, 5820.912686309709, 5821.09772985188, 5827.271591051119, 5749.223854779551, 5785.595008349459, 5792.623479473821, 5800.8259752207505, 5894.616849904743, 5825.0388685866355, 5838.2702162229725, 5842.415758424208, 5848.941510584925, 5882.029465138205, 5782.219400380979, 5831.708414579254, 5835.94164058354, 5843.357230704619, 5851.561132915049, 4490.101979604092, 4495.100979803987, 4551.749653769009, 4566.246569316092, 4573.862784116482, 4029.4560234368573, 4052.878413647595, 4070.61329173728, 4079.9796001019804, 4089.8364065437645, 5622.437756224426, 5632.8028519002455, 5634.549236061105, 5645.096784514458, 5674.858128546819, 5747.166660834239, 5789.8552536186935, 5857.355690874, 5910.940890591125, 5914.112883067574, 5664.20701101846, 5665.12190610456, 5675.404082571353, 5688.260526131659, 5702.54379649627, 5162.5095615916425, 5176.81881134166, 5180.818671346485, 5183.067047931333, 5230.0585894539345, 5927.1405646181065, 6054.303755068047, 6128.228138398679, 6177.949748542758, 6196.194494715748, 5956.195913551615, 6003.3996600339615, 6012.5791194617705, 6031.24609423822, 6034.094885766995, 6214.9067763984485, 6234.688265586612, 6249.843753906189, 6277.435030847246, 6291.622502649856, 5628.549716022627, 5641.4358564144895, 5926.377730338252, 5939.2575928009, 5971.193888824953, 5840.620359676607, 5861.882762344644, 5872.031114865999, 5937.465628093492, 5974.701264936823, 5756.913646295393, 5784.913226301524, 5789.710514474175, 5790.363060063474, 5792.53659707214, 5548.361938377138, 5784.855378615568, 5789.957807594674, 5790.623609465371, 5792.899349123653, 5494.066008778597, 5608.551315894637, 5655.773769049357, 5668.688222147822, 5744.454276843693, 5745.540356771365, 5795.681237531976, 5798.1302804579655, 5802.071668533014, 5805.3614102447855, 5466.453354664502, 5501.119820828648, 5505.394406615349, 5664.320281566073, 5674.546036317167], "value": 5433.675850209056, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9273840769904, 596.0284735880514, 627.6641996531855, 649.3117295666591, 651.9576227545206, 33892.32215355695, 44774.55225447753, 44795.32807007893, 44982.7750861246, 44999.77500112499, 47894.04211915768, 48263.27605085926, 48386.27420588694, 48410.75794621022, 48413.27380089302, 8227.794305142359, 8407.201315875012, 8700.999999999984, 8840.778980525474, 8841.336899732514, 10340.741481462986, 10587.894121058767, 10609.734756631107, 10846.403447810368, 10866.34801911884, 10777.191710621735, 10836.295640783324, 10847.457627118652, 10852.023317901387, 10854.023137917626, 10609.522571484264, 10627.468626568641, 10659.360438373684, 10660.680179594625, 10665.78668426631, 10457.163426925828, 10517.001769663739, 10518.211134164969, 10527.736806579896, 10540.578376864916, 42925.0, 43187.35218971718, 43238.35142472865, 43269.35095973563, 43315.78342108301, 3492.912677183065, 3550.130218096557, 3595.1910820065536, 3721.888343349704, 4240.109576988836, 32294.51558226605, 32409.83795081033, 32599.185020374443, 32732.0, 33582.49626255608, 3904.7657140571655, 3910.511186101737, 3950.822213000422, 3953.189596132786, 4014.598540145991, 367383.0, 480488.0, 483047.0, 486241.0, 490218.0, 63918.68040659767, 64285.0, 64329.391765205306, 64436.677816610616, 64437.35562644407, 35499.64500354963, 35839.641603584154, 67356.0, 67698.66150669215, 67748.6612566934, 15659.2953317101, 15695.293711782997, 15698.76451853223, 15705.450309239122, 15705.607359816097, 11489.712757181138, 11651.359175245274, 11655.30068195911, 12221.816672749916, 12349.629511114681, 19067.379272761693, 19779.23359956904, 19868.60262794765, 19917.60164796696, 20008.2997095101, 6962.825929351807, 7197.0, 7305.232950540223, 7416.814579635445, 7433.145188303414, 1016.7763092119721, 1067.3969207397795, 1128.4132251229314, 1133.1218305812897, 1133.9546418143348, 33121.0, 33643.495347569806, 33671.0, 33889.491657625156, 34222.14444638854, 983.2723784399493, 1146.7649131927935, 1151.7638884028754, 1167.3987896233446, 1195.0738177912187, 15741.527754167393, 17517.474475765746, 17557.561060973323, 18330.90834545819, 18525.81474185268, 531568.0, 534203.0, 534508.0, 535204.0, 538228.0, 60357.698211508665, 60934.39065609287, 60978.69510652418, 60989.69505152446, 61286.0, 1312.960611181647, 1357.429879450633, 1379.6275005748591, 1412.9788053179211, 1422.6301161698034, 30039.849800750857, 34294.14264643404, 34702.30595388129, 34872.82563587166, 35373.64626353807, 51784.74107629438, 57770.71114644568, 58723.70638146782, 58989.70505147447, 63718.681406592674, 472703.0, 475640.0, 475717.0, 476180.0, 478583.0, 27757.30606734767, 27874.58188127139, 28001.71998279991, 31560.26418547002, 46029.07941841211, 49256.507434925195, 49353.75323123361, 49688.75155624199, 50260.74869625628, 50540.24189637232, 40163.79918100391, 40900.79549602233, 41462.79268603637, 42614.0, 42835.14329713326, 41352.37971430371, 41878.0, 42142.57857421509, 42225.36661950134, 43098.353524696526, 43283.567164329215, 43285.78357108194, 43933.02301396381, 44360.0, 44516.55483445124, 35193.82403087968, 37629.0, 37648.24703505969, 38641.61358386493, 38902.41646375363, 29090.272743180743, 29512.409751805273, 29780.851095744383, 29867.55198672065, 29884.0], "value": 21183.5921930675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.68811858927927, 408.922304762095, 416.77494153157295, 422.91541691661666, 431.54687578043047, 16195.0, 19069.90465047676, 19775.5056123597, 19847.404577862686, 19949.900250498744, 19602.215911363528, 19956.0, 20127.899360503212, 20265.290714824947, 20277.0, 5295.4704529547125, 5779.393163717812, 5989.580729348925, 6568.7700930467445, 6615.801525954229, 6502.382273683992, 6538.476921846241, 6691.93308066918, 6713.798586042427, 6723.46212303017, 6576.309487503815, 6624.039514270428, 6625.271220165802, 6625.60246385216, 6628.5691430056895, 6409.327020662833, 6567.704453299613, 6625.867482650344, 6626.304238054983, 6634.834129146786, 5874.441928016831, 5884.7940322088525, 5888.29340479141, 5891.675957822318, 5895.734691938873, 23727.76272237273, 24072.398190045213, 24081.397965050837, 24165.637515437284, 24377.14679986192, 2512.1458704040715, 2631.8947242110294, 2632.4866651003063, 2775.9167224983285, 2937.456570534458, 14995.32521036556, 15029.699406011929, 15088.0, 15336.923315383463, 15781.13203773792, 1896.753422055138, 1948.5323522354674, 1983.2959299448632, 1990.8606397552178, 2011.3965810256864, 82545.0, 84719.99999999939, 85060.0, 85070.0, 85820.0, 10861.511231994578, 10863.239573229956, 10951.507182176822, 11102.500387482583, 11303.265287756269, 15080.849191507945, 15163.848361516244, 15172.544823655307, 15199.164045977577, 15236.847631523542, 7700.422468314787, 7823.765287041284, 8052.355811535063, 8292.253697167163, 8342.541160236246, 7694.692212311556, 7716.151223365426, 7731.729389471341, 7844.097928738154, 7943.046834379911, 6743.527953043338, 6798.286179951034, 6799.7280108796085, 6818.659067046628, 6937.410320122745, 1885.820847019531, 1990.6317331293758, 2008.9296874609317, 2014.8791072535694, 2054.5207450635517, 948.9478078705738, 1058.9523471443804, 1076.3488089705615, 1111.6700451740426, 1130.1128614038105, 20087.5493647942, 20668.0, 20792.89603552003, 20803.1678732852, 21166.47083822917, 991.3605724307781, 1008.3395376028712, 1032.0659802878406, 1039.3400190878847, 1089.515165751233, 10679.946600266949, 11751.236169648946, 11764.470598823074, 11791.0, 11845.23006004607, 388979.0, 391034.0, 391287.0, 480934.0, 495840.0, 58341.0, 68302.0, 76516.0, 87559.56220218986, 88156.55921720351, 997.9351342162736, 1024.109025148126, 1047.1413440978324, 1060.7136073260176, 1068.6206396729206, 13699.726005479635, 16546.42087526931, 17205.537529309648, 18249.90875045616, 18515.444536663923, 28610.403872766503, 32586.674133258362, 35496.0, 38777.806110969264, 42313.78843105765, 57812.0, 58130.12804807847, 58812.411875880694, 59021.704891476984, 60137.0, 7282.745103921337, 7564.848703025798, 7579.0905091387185, 7581.203973582695, 7683.0780306363595, 13204.141730787467, 13472.326383680973, 13517.932410337886, 13561.93219033938, 13754.105983111065, 11724.765504689687, 11783.469743861375, 11786.410679466164, 12107.818382724443, 12336.938315308365, 11433.314001159957, 11790.351530665896, 11978.520859165885, 12004.279743215086, 12074.215176013882, 11698.649040528799, 12033.45849436795, 12039.217450866015, 12064.819027714415, 12324.630261092181, 7369.926300736924, 7415.592142432002, 7586.582737949245, 7896.407769417202, 8656.350773691873, 11875.287482751062, 12203.877961220274, 12327.445264962918, 12767.0, 12798.16811907223], "value": 9565.089979493667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.9853601463985, 1501.932413041413, 1622.756586512024, 1736.4009416751217, 1780.6527727093214, 7891.881621775671, 8401.53791541465, 8405.411621186504, 8406.411551191411, 8412.284955778758, 7414.814629634262, 7580.204078571739, 8060.113387527367, 8293.33653307734, 8341.249287564118, 2322.129201549419, 2346.3664810501155, 2347.096367898363, 2350.647402889572, 2353.0, 2372.0511795281855, 2404.5671779079757, 2426.454047839231, 2426.987865060681, 2428.0651948999675, 2403.194929698553, 2405.0980882169188, 2411.5297516984197, 2442.2306973303353, 2473.468204336067, 2378.452955820154, 2402.243293362585, 2412.975870241293, 2418.069043418279, 2426.0417135231573, 2396.9520609587885, 2411.1078900806638, 2412.6622272881636, 2414.1912459326145, 2419.63705444183, 8583.0, 8585.699500517452, 8627.870581941275, 8633.568321583958, 8644.654213831502, 5340.599455040888, 5472.863178420532, 5478.45215478453, 5484.7531861066345, 5492.368377636583, 3426.8971930842113, 3429.416999110157, 3549.1304630365466, 3626.8005259710703, 3641.8543258269638, 1066.211003857148, 1081.3133660125798, 1096.1614365010773, 1129.5989923577094, 1179.3218899132946, 11812.822807657805, 11884.584039558575, 11930.880691193064, 11948.163628546004, 11959.760804783942, 4722.386089808303, 4765.11845308619, 4838.516148385203, 4870.780814863339, 4939.160342741742, 9925.900740992498, 9937.453440060866, 9938.45338506389, 9942.502874856229, 9945.552450139761, 5463.071277882769, 5521.365043020104, 5530.0, 5530.695811730394, 5555.722213889289, 4427.63121729873, 4481.462224533012, 4934.062528119646, 4988.251762235694, 5078.847634570969, 4015.0966032642423, 4101.815418306183, 4154.833806647761, 4172.4993000840095, 4203.096334288142, 1355.3833005982253, 1377.0, 1378.2832926877968, 1393.853645367242, 1398.3847107272768, 916.5966974531185, 926.666400095965, 927.8793756811572, 942.222666300305, 946.370663508759, 5697.0, 5778.711064446761, 5801.837998290942, 6058.848528786727, 6079.574429789961, 457.28434999226107, 460.0982075132777, 461.9769011549409, 467.06120697397796, 472.36702818223745, 3990.1114199227745, 4037.0916543777416, 4059.837606495766, 4063.39049142631, 4092.6930480214105, 9983.60065597368, 9994.750131246632, 10059.899401006043, 10068.798624027479, 10071.748206294902, 9960.053794889474, 9980.351277166961, 9985.800283994426, 9992.550335234931, 9999.200063994864, 7744.954431151722, 7807.180246074194, 7824.295813376823, 7833.060032795987, 7839.25527074927, 5450.754716037709, 5584.664920104807, 5699.202111704281, 5717.571182161438, 5837.153612726216, 9166.0, 9185.311101667268, 9200.0, 9226.815463690822, 9284.02517735628, 9058.6447523643, 9237.353385262966, 9272.536373181449, 9327.58025888823, 9334.973152953035, 7079.575225486487, 7195.424366050599, 7252.202257751537, 7264.67308971087, 7344.48588598793, 8311.293540049164, 8371.121032291521, 8377.70678026266, 8383.245507904317, 8391.202835730595, 7003.26465721092, 7008.474364422791, 7203.351698347174, 7365.926340736738, 7585.734499292498, 7129.0, 7339.889901651372, 7366.373858222111, 7375.8156046099275, 7557.0, 6867.278935711878, 6988.685509151998, 6992.79021629352, 6994.615296158557, 6997.090378250795, 4981.336143266909, 4982.950170498249, 5063.3417655704525, 5082.313887625123, 5096.439391666988, 4931.0, 4934.827281045146, 5098.898022039612, 5104.310918026019, 5128.128218202989], "value": 4488.629604649845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.9401701710709, 352.88002079293045, 360.48450715476866, 365.74580666436805, 371.47807330700357, 5122.975404919012, 5275.73621318934, 5305.575553955684, 5321.600879934011, 5334.253204551361, 5050.797968081272, 5135.690398948263, 5142.640015198937, 5191.143461328886, 5206.817761378353, 4144.875653730385, 4159.209750147477, 4161.895952601179, 4170.374443833419, 4176.102138040321, 4116.094459218967, 4156.355764856452, 4158.671144159265, 4165.291900376928, 4172.228137794517, 4156.688248381369, 4163.958360416403, 4170.687198460112, 4172.812223449937, 4173.227952828721, 4154.169166166764, 4172.895677608069, 4182.494302051259, 4191.832326706928, 4207.1165055338415, 3701.222743223926, 3798.0694729791103, 3801.904952376185, 3806.543214814212, 3807.9428808567895, 5120.92318615221, 5144.4083930348115, 5148.871278218037, 5152.793888244466, 5158.664686795346, 4838.782254798507, 4853.490383509716, 4853.611711063107, 4856.927146092811, 4867.780949857265, 5367.838964831061, 5536.363318218416, 5548.944510554883, 5549.639273447213, 5558.499735023867, 4184.539700632928, 4194.0, 4195.056112374722, 4221.978890105561, 4227.619514243702, 5723.885522289573, 5737.741801618896, 5751.25233719618, 5758.913616295759, 5761.481466667978, 4107.568705285962, 4245.702800803976, 4247.32042873145, 4259.190753756776, 4325.437693099877, 4303.289957157097, 4312.460942382202, 4331.133773245364, 4332.848350307724, 4333.678228140385, 4794.520547945178, 4803.366855269225, 4819.7108173509705, 4826.855194344175, 4848.975755121272, 5336.1195402758885, 5555.944440555542, 5565.860853478614, 5641.464060914206, 5645.604807663424, 1388.438007241853, 1406.9577912662637, 1427.978580321296, 1449.4564538298139, 1461.8684318411395, 1006.4615430744517, 1027.3681685763202, 1036.5231993283023, 1051.500537244818, 1052.0689190066846, 5166.250893620404, 5166.405863325691, 5168.759497720595, 5179.533841954242, 5179.870503237449, 5427.891442171134, 5428.5385742211565, 5438.673679579238, 5446.564274858002, 5453.182022696627, 5153.613478989091, 5160.561916751591, 5196.948030519722, 5226.268322434862, 5405.864853378697, 2896.391757730858, 2920.5619157126603, 2931.3551018775834, 2931.648202215748, 2940.5442156465783, 5670.858228544237, 5716.742746576414, 5741.913871291934, 5749.0, 5803.709814509258, 5465.770201704664, 5526.811735476892, 5561.221428999862, 5587.916181257285, 5598.7045311422125, 5663.292088488856, 5710.457506536873, 5717.256756621613, 5722.856928576819, 5732.340780810094, 5340.706261155518, 5489.807856724996, 5509.641873278224, 5510.641808282448, 5602.761418074114, 5358.276632654698, 5359.732013399236, 5364.731763411735, 5372.382176049804, 5404.891902162013, 5650.29371328584, 5665.546756259571, 5682.460166284196, 5690.459406356389, 5733.799317023884, 3826.368649172967, 3995.2409042281874, 4002.45966794479, 4013.157236980267, 4064.4106604542767, 5428.669975855941, 5449.100898351728, 5474.562035037267, 5486.862828429162, 5574.526165275997, 5410.269613602113, 5420.918686219631, 5440.694233384039, 5448.318960129984, 5467.043267428264, 5474.42518535564, 5478.369987451494, 5538.224648549287, 5568.549838071236, 5590.413006634245, 5263.5525980292105, 5451.20957461158, 5471.781128754806, 5493.807716729895, 5562.388137304974, 5502.706863886903, 5526.55787536988, 5526.778928842801, 5536.2249285100925, 5543.0, 5271.894562108813, 5429.67421954684, 5443.319585051869, 5457.508824205841, 5471.37079235893], "value": 4237.607011283793, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.2213699286868, 646.1664452855815, 655.3773914780959, 669.8961660942556, 682.7064362324202, 12562.057845661579, 12917.35413229337, 12956.222626642408, 12958.222506649608, 12976.026797990142, 12240.143189976705, 12364.690882727937, 12369.319687417212, 12369.505219791197, 12383.69040773981, 714.5748279773527, 732.9267073292655, 809.5385630190793, 822.9917700823005, 849.0957130655862, 846.2933450568783, 848.0840692052599, 849.0829903704016, 849.2441726863066, 850.1371108325055, 893.13366034946, 894.4767311123001, 894.7584152278881, 894.7628878347243, 895.0110128308223, 743.7248218159289, 758.6055251269337, 873.9082396348388, 885.0397318908991, 896.44420459315, 634.0267689097213, 634.6921742954663, 635.3709827270968, 635.71710588788, 636.8885445047098, 11598.652040438801, 11675.182737208399, 11689.532418703242, 11729.941350293278, 11821.408929553489, 12554.81167782484, 12603.873961260362, 12791.936040319739, 12849.164804287784, 12938.87061129386, 9988.250881183867, 10000.849987250198, 10038.64864729731, 10243.07812296897, 10265.486725663686, 3003.0, 3009.774266929989, 3017.9547306790414, 3033.848307584612, 3058.082575227445, 56851.999999999585, 62158.37841621616, 62570.68714656443, 63662.0, 64773.0, 9960.203183745283, 10467.371957682564, 10589.311694739818, 10618.150547956146, 10746.677599671866, 18781.248750049846, 18880.24479020851, 18929.526761831065, 18941.147648355858, 18952.336668216547, 7216.963915180496, 7245.130584329809, 7351.8162045949275, 7479.551226926402, 7507.549547027196, 3829.349010668193, 3954.0905591714068, 3959.346707793182, 3962.306596345628, 3969.702272329587, 3152.3537674776617, 3272.969014760343, 3274.279658475132, 3276.574045374086, 3277.410066188109, 564.8700798816213, 611.7430679114693, 612.1491127333011, 613.2671457608204, 639.9936000639934, 486.9756512174377, 528.3422139436426, 553.5267346418754, 567.9403662615448, 576.2105914896534, 7466.2509867401795, 7495.287947644965, 7605.885911711329, 7833.960830195927, 8031.678732850737, 543.9265699130646, 546.7594258526316, 560.6047736345866, 566.8554518597731, 574.5719439017959, 3745.831437585315, 3758.9248215035545, 3804.9429258561145, 3818.236352729465, 3897.337452633059, 87973.56013219892, 88237.55881220553, 89238.10761892427, 90493.54753226192, 90666.54666726624, 64247.678761606825, 77678.22321776823, 78069.0, 78971.21028789639, 79867.0, 69179.3082069183, 70175.2982470179, 70312.0, 71404.0, 73462.26537734662, 7110.85778284421, 7261.963690181516, 7352.11774587053, 7481.139668938142, 7494.668022085317, 47019.52980470152, 47123.52876471329, 47138.76430617825, 48230.5176948226, 49150.5084949146, 62985.68507157435, 64303.35696642974, 65104.67447662731, 65214.34785652083, 67801.66099169472, 10302.175825934057, 10321.74195645115, 10574.41840698769, 10640.134117670326, 10677.305975111592, 10836.837447438136, 10870.456477176267, 10966.835497467704, 11010.559577617127, 11212.0, 9775.75560610962, 11032.117430605693, 11202.327860328407, 11440.370779607201, 12058.095642826998, 11552.133589980953, 11593.884061159617, 11633.185677002528, 11691.766164676828, 11861.991730702643, 11080.61217857371, 11176.944115279372, 11304.717382065513, 11460.19778615489, 11479.713007174887, 9308.394954327947, 9480.383775054599, 9491.288153388385, 9631.9036809631, 10160.441175735405, 9135.451872887383, 9462.384944978554, 9598.376105553116, 9612.807743845224, 9678.225741940769], "value": 6474.479836186848, "unit": "score"}], "name": "dromaeo_css", "value": 7167.6763387160945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 110.0, 110.0, 111.0, 113.0, 110.0, 112.0, 112.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 119.0, 118.0, 164.0, 120.0, 117.0, 118.0, 118.0, 159.0, 120.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 159.0, 164.0, 160.0, 159.0, 158.0, 159.0, 160.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 106.0, 76.0, 76.0, 76.0, 75.0, 111.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 123.0, 81.0, 82.0, 83.0, 105.0, 81.0, 82.0, 108.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 51.0, 50.0, 50.0, 50.0, 50.0, 50.0, 49.0, 51.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 62.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 80.0, 76.0, 75.0, 79.0, 79.0, 75.0, 75.0, 73.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 121.0, 123.0, 122.0, 131.0, 126.0, 131.0, 172.0, 135.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 152.0, 155.0, 157.0, 157.0, 155.0, 154.0, 153.0, 153.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 63.0, 62.0, 67.0, 63.0, 65.0, 62.0, 61.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1457.4999999999998, "alertThreshold": 2.0}]} 21:06:33 INFO - Return code: 0 21:06:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:06:33 INFO - # TBPL SUCCESS # 21:06:33 INFO - Running post-action listener: _resource_record_post_action 21:06:33 INFO - [mozharness: 2016-12-16 05:06:33.931820Z] Finished run-tests step (success) 21:06:33 INFO - Running post-run listener: _resource_record_post_run 21:06:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 360898560; Read time: 0; Write time: 258612 21:06:34 INFO - TinderboxPrint: CPU usage
13.0% 21:06:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:06:34 INFO - TinderboxPrint: I/O write bytes / time
360,898,560 / 258,612 21:06:34 INFO - TinderboxPrint: CPU idle
8,276.5 (87.0%) 21:06:34 INFO - TinderboxPrint: CPU user
1,192.3 (12.5%) 21:06:34 INFO - TinderboxPrint: Swap in / out
0 / 0 21:06:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114229248; Read time: 0; Write time: 113340 21:06:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 246321152; Read time: 0; Write time: 145228 21:06:34 INFO - Running post-run listener: _upload_blobber_files 21:06:34 INFO - Blob upload gear active. 21:06:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:06:34 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 21:06:34 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'] 21:06:34 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 21:06:34 INFO - (blobuploader) - INFO - Open directory for files ... 21:06:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:06:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:06:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:35 INFO - (blobuploader) - INFO - Done attempting. 21:06:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:06:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:06:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:39 INFO - (blobuploader) - INFO - Done attempting. 21:06:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:06:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:06:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:40 INFO - (blobuploader) - INFO - Done attempting. 21:06:40 INFO - (blobuploader) - INFO - Iteration through files over. 21:06:40 INFO - Return code: 0 21:06:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:06:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:06:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/020a13db1ef70c26c89e1c976b3fef2d08f26e023b20c525c0f2595d47cd655a91181acff9ea487c54ed6efea7d902cab62638ace831ba66a4feefa20b0e812a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b81c6037773cd4f32decfe07fbec7860823cb9cb42e5a37fe3fca2e94f9547f0563a844b3be7b4c86b7ed187e578e410346a2706ff3683cf91270f2cb7a698c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c371c612584708083634ad7ab8225ffd82514715dbca5d9a8eaa2e563aad0a67fe6c6321136063d2aff85a56386ca39bf81cb5649e8dc39fba31170c74306331"} 21:06:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:06:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:06:40 INFO - Contents: 21:06:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/020a13db1ef70c26c89e1c976b3fef2d08f26e023b20c525c0f2595d47cd655a91181acff9ea487c54ed6efea7d902cab62638ace831ba66a4feefa20b0e812a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b81c6037773cd4f32decfe07fbec7860823cb9cb42e5a37fe3fca2e94f9547f0563a844b3be7b4c86b7ed187e578e410346a2706ff3683cf91270f2cb7a698c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c371c612584708083634ad7ab8225ffd82514715dbca5d9a8eaa2e563aad0a67fe6c6321136063d2aff85a56386ca39bf81cb5649e8dc39fba31170c74306331"} 21:06:40 INFO - Running post-run listener: copy_logs_to_upload_dir 21:06:40 INFO - Copying logs to upload dir... 21:06:40 INFO - mkdir: /builds/slave/test/build/upload/logs 21:06:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.574894 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-15 21:06:40.458069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 21:06:40.465989) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329 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/020a13db1ef70c26c89e1c976b3fef2d08f26e023b20c525c0f2595d47cd655a91181acff9ea487c54ed6efea7d902cab62638ace831ba66a4feefa20b0e812a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b81c6037773cd4f32decfe07fbec7860823cb9cb42e5a37fe3fca2e94f9547f0563a844b3be7b4c86b7ed187e578e410346a2706ff3683cf91270f2cb7a698c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c371c612584708083634ad7ab8225ffd82514715dbca5d9a8eaa2e563aad0a67fe6c6321136063d2aff85a56386ca39bf81cb5649e8dc39fba31170c74306331"} build_url:https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011704 build_url: 'https://queue.taskcluster.net/v1/task/U1oUl6vLQCiHJX3zJyPWcg/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/020a13db1ef70c26c89e1c976b3fef2d08f26e023b20c525c0f2595d47cd655a91181acff9ea487c54ed6efea7d902cab62638ace831ba66a4feefa20b0e812a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b81c6037773cd4f32decfe07fbec7860823cb9cb42e5a37fe3fca2e94f9547f0563a844b3be7b4c86b7ed187e578e410346a2706ff3683cf91270f2cb7a698c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c371c612584708083634ad7ab8225ffd82514715dbca5d9a8eaa2e563aad0a67fe6c6321136063d2aff85a56386ca39bf81cb5649e8dc39fba31170c74306331"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 21:06:40.494729) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 21:06:40.495076) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481863562.505968-1080365329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 21:06:40.574423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 21:06:40.574761) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 21:06:40.575060) ========= ========= Total master_lag: 0.18 =========