builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1479249431.28 results: success (0) buildid: 20161115115349 builduid: bcb6b2599da74adbbce2d9d08ca0f296 revision: 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:11.285000) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:11.285452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:11.285763) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:11.301362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:11.301650) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-15 14:37:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.2M=0s 2016-11-15 14:37:11 (70.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093733 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:11.409856) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:11.410147) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020400 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:11.459002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:11.459344) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 --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 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 --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=9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-15 14:37:11,655 truncating revision to first 12 chars 2016-11-15 14:37:11,655 Setting DEBUG logging. 2016-11-15 14:37:11,655 attempt 1/10 2016-11-15 14:37:11,655 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/07f57a55ee1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 14:37:11,970 unpacking tar archive at: mozilla-aurora-07f57a55ee1b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646854 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:12.119227) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:12.119512) ========= script_repo_revision: 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:12.119907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:12.120231) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 14:37:12.128555) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-15 14:37:12.128877) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:37:12 INFO - MultiFileLogger online at 20161115 14:37:12 in /builds/slave/test 14:37:12 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 14:37:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:37:12 INFO - {'append_to_log': False, 14:37:12 INFO - 'base_work_dir': '/builds/slave/test', 14:37:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:37:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:37:12 INFO - 'branch': 'Mozilla-Aurora', 14:37:12 INFO - 'buildbot_json_path': 'buildprops.json', 14:37:12 INFO - 'config_files': ('talos/linux_config.py',), 14:37:12 INFO - 'default_actions': ('clobber', 14:37:12 INFO - 'read-buildbot-config', 14:37:12 INFO - 'download-and-extract', 14:37:12 INFO - 'populate-webroot', 14:37:12 INFO - 'create-virtualenv', 14:37:12 INFO - 'install', 14:37:12 INFO - 'run-tests'), 14:37:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:37:12 INFO - 'download_minidump_stackwalk': True, 14:37:12 INFO - 'download_symbols': 'ondemand', 14:37:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:37:12 INFO - 'tooltool.py': '/tools/tooltool.py', 14:37:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:37:12 INFO - '/tools/misc-python/virtualenv.py')}, 14:37:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:37:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:37:12 INFO - 'installer_path': 'installer.exe', 14:37:12 INFO - 'log_level': 'info', 14:37:12 INFO - 'log_name': 'talos', 14:37:12 INFO - 'log_to_console': True, 14:37:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:37:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:37:12 INFO - 'opt_config_files': (), 14:37:12 INFO - 'pip_index': False, 14:37:12 INFO - 'sps_profile': False, 14:37:12 INFO - 'sps_profile_interval': 0, 14:37:12 INFO - 'suite': 'dromaeojs', 14:37:12 INFO - 'system_bits': '32', 14:37:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:37:12 INFO - 'title': 'talos-linux64-ix-013', 14:37:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:37:12 INFO - 'use_talos_json': True, 14:37:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:37:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:37:12 INFO - 'work_dir': 'build'} 14:37:12 INFO - [mozharness: 2016-11-15 22:37:12.424822Z] Running clobber step. 14:37:12 INFO - Running pre-action listener: _resource_record_pre_action 14:37:12 INFO - Running main action method: clobber 14:37:12 INFO - rmtree: /builds/slave/test/build 14:37:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:37:13 INFO - Running post-action listener: _resource_record_post_action 14:37:13 INFO - [mozharness: 2016-11-15 22:37:13.394414Z] Finished clobber step (success) 14:37:13 INFO - [mozharness: 2016-11-15 22:37:13.394513Z] Running read-buildbot-config step. 14:37:13 INFO - Running pre-action listener: _resource_record_pre_action 14:37:13 INFO - Running main action method: read_buildbot_config 14:37:13 INFO - Using buildbot properties: 14:37:13 INFO - { 14:37:13 INFO - "project": "", 14:37:13 INFO - "product": "firefox", 14:37:13 INFO - "script_repo_revision": "production", 14:37:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:37:13 INFO - "repository": "", 14:37:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:37:13 INFO - "buildid": "20161115115349", 14:37:13 INFO - "pgo_build": "True", 14:37:13 INFO - "basedir": "/builds/slave/test", 14:37:13 INFO - "buildnumber": 906, 14:37:13 INFO - "slavename": "talos-linux64-ix-013", 14:37:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:37:13 INFO - "platform": "ubuntu64_hw", 14:37:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:37:13 INFO - "branch": "mozilla-aurora", 14:37:13 INFO - "repo_path": "releases/mozilla-aurora", 14:37:13 INFO - "revision": "07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09", 14:37:13 INFO - "stage_platform": "linux64-pgo", 14:37:13 INFO - "builduid": "bcb6b2599da74adbbce2d9d08ca0f296", 14:37:13 INFO - "slavebuilddir": "test" 14:37:13 INFO - } 14:37:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 14:37:13 INFO - Running post-action listener: _resource_record_post_action 14:37:13 INFO - [mozharness: 2016-11-15 22:37:13.396971Z] Finished read-buildbot-config step (success) 14:37:13 INFO - [mozharness: 2016-11-15 22:37:13.397059Z] Running download-and-extract step. 14:37:13 INFO - Running pre-action listener: _resource_record_pre_action 14:37:13 INFO - Running main action method: download_and_extract 14:37:13 INFO - mkdir: /builds/slave/test/build/tests 14:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:13 INFO - trying https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:37:13 INFO - Downloading https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/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 14:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/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 14:37:13 INFO - Downloaded 1361 bytes. 14:37:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:37:13 INFO - Using the following test package requirements: 14:37:13 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:37:13 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:37:13 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:37:13 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:13 INFO - u'jsshell-linux-x86_64.zip'], 14:37:13 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:37:13 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:37:13 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:37:13 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:37:13 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:37:13 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:37:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:37:13 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:37:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:37:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:37:13 INFO - Fetch https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:37:14 INFO - Http code: 200 14:37:14 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 14:37:14 INFO - x-amz-cf-id: _gSAji5i_f7n0URqXja63p5FCqchyeTMmqninFRee67ezeqkceo8Ew== 14:37:14 INFO - x-amz-version-id: Q5QG9R_6x9a8y2SbBcCCFlczEBTM1M95 14:37:14 INFO - Expected file size: 21999539 14:37:14 INFO - Obtained file size: 21999539 14:37:18 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 14:37:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:37:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:37:18 INFO - Fetch https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:37:19 INFO - Http code: 200 14:37:19 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 14:37:19 INFO - x-amz-cf-id: E5zutW9ZlRQHligxMuRnNN2fkR6yjGpIKJNpZOESTPwNq8SnvyYRoQ== 14:37:19 INFO - x-amz-version-id: Q5QG9R_6x9a8y2SbBcCCFlczEBTM1M95 14:37:19 INFO - Expected file size: 21999539 14:37:19 INFO - Obtained file size: 21999539 14:37:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 14:37:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:37:24 INFO - Fetch https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:37:24 INFO - Http code: 200 14:37:24 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 14:37:24 INFO - x-amz-cf-id: iyqALRs7sj0q2jnWFWYPvwyUFZ3sP6Sr6dC5OfuOU67jj6J5br3cKQ== 14:37:24 INFO - x-amz-version-id: co2KDB4uNjeq.XNIaZURO5GpPzYC3XdF 14:37:24 INFO - Expected file size: 14409038 14:37:24 INFO - Obtained file size: 14409038 14:37:25 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')]} 14:37:25 INFO - trying https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:37:25 INFO - Downloading https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/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 14:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/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 14:37:26 INFO - Downloaded 63860292 bytes. 14:37:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:37:26 INFO - mkdir: /builds/slave/test/properties 14:37:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:37:26 INFO - Writing to file /builds/slave/test/properties/build_url 14:37:26 INFO - Contents: 14:37:26 INFO - build_url:https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:37:27 INFO - Running post-action listener: _resource_record_post_action 14:37:27 INFO - Running post-action listener: set_extra_try_arguments 14:37:27 INFO - [mozharness: 2016-11-15 22:37:27.198123Z] Finished download-and-extract step (success) 14:37:27 INFO - [mozharness: 2016-11-15 22:37:27.198348Z] Running populate-webroot step. 14:37:27 INFO - Running pre-action listener: _resource_record_pre_action 14:37:27 INFO - Running main action method: populate_webroot 14:37:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:37:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:37:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:37:27 INFO - '--tppagecycles', 14:37:27 INFO - '7'], 14:37:27 INFO - 'tests': ['tsvgm']}}, 14:37:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:37:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:37:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:37:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:37:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['damp', 'tps']}, 14:37:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'tests': ['damp', 'tps']}, 14:37:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['dromaeo_dom']}, 14:37:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:37:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['basic_compositor_video']}, 14:37:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:37:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other-e10s': {'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['tsvgx', 14:37:27 INFO - 'tsvgr_opacity', 14:37:27 INFO - 'tart', 14:37:27 INFO - 'tscrollx', 14:37:27 INFO - 'cart']}, 14:37:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:37:27 INFO - 'tsvgr_opacity', 14:37:27 INFO - 'tart', 14:37:27 INFO - 'tscrollx', 14:37:27 INFO - 'cart']}, 14:37:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['tp5o']}, 14:37:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'tests': ['tp5o']}, 14:37:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--disable-e10s', 14:37:27 INFO - '--xperf_path', 14:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:27 INFO - 'tests': ['tp5n']}, 14:37:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--xperf_path', 14:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:27 INFO - 'tests': ['tp5n']}}, 14:37:27 INFO - 'talos.zip': {'path': '', 14:37:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:37:27 INFO - Running post-action listener: _resource_record_post_action 14:37:27 INFO - [mozharness: 2016-11-15 22:37:27.218035Z] Finished populate-webroot step (success) 14:37:27 INFO - [mozharness: 2016-11-15 22:37:27.218123Z] Running create-virtualenv step. 14:37:27 INFO - Running pre-action listener: _resource_record_pre_action 14:37:27 INFO - Running main action method: create_virtualenv 14:37:27 INFO - Creating virtualenv /builds/slave/test/build/venv 14:37:27 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 14:37:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:37:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:37:27 INFO - Using real prefix '/usr' 14:37:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:37:27 INFO - Installing distribute.............................................................................................................................................................................................done. 14:37:29 INFO - Installing pip.................done. 14:37:29 INFO - Return code: 0 14:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:37:30 INFO - Reading from file tmpfile_stdout 14:37:30 INFO - Output received: 14:37:30 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) 14:37:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37: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', 'pip>=1.5'] in /builds/slave/test/build 14:37: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 pip>=1.5 14:37:30 INFO - Using env: {'DISPLAY': ':0', 14:37:30 INFO - 'HOME': '/home/cltbld', 14:37:30 INFO - 'LANG': 'en_US.UTF-8', 14:37:30 INFO - 'LANGUAGE': 'en_US:en', 14:37:30 INFO - 'LOGNAME': 'cltbld', 14:37:30 INFO - 'MAIL': '/var/mail/cltbld', 14:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:30 INFO - 'MOZ_NO_REMOTE': '1', 14:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:30 INFO - 'NO_EM_RESTART': '1', 14:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:30 INFO - 'PWD': '/builds/slave/test', 14:37:30 INFO - 'SHELL': '/bin/bash', 14:37:30 INFO - 'SHLVL': '1', 14:37:30 INFO - 'TERM': 'linux', 14:37:30 INFO - 'TMOUT': '86400', 14:37:30 INFO - 'USER': 'cltbld', 14:37:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:30 INFO - '_': '/tools/buildbot/bin/python'} 14:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:30 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 14:37:30 INFO - Cleaning up... 14:37:30 INFO - Return code: 0 14:37:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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', '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 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:37: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 psutil>=3.1.1 14:37:30 INFO - Using env: {'DISPLAY': ':0', 14:37:30 INFO - 'HOME': '/home/cltbld', 14:37:30 INFO - 'LANG': 'en_US.UTF-8', 14:37:30 INFO - 'LANGUAGE': 'en_US:en', 14:37:30 INFO - 'LOGNAME': 'cltbld', 14:37:30 INFO - 'MAIL': '/var/mail/cltbld', 14:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:30 INFO - 'MOZ_NO_REMOTE': '1', 14:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:30 INFO - 'NO_EM_RESTART': '1', 14:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:30 INFO - 'PWD': '/builds/slave/test', 14:37:30 INFO - 'SHELL': '/bin/bash', 14:37:30 INFO - 'SHLVL': '1', 14:37:30 INFO - 'TERM': 'linux', 14:37:30 INFO - 'TMOUT': '86400', 14:37:30 INFO - 'USER': 'cltbld', 14:37:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:30 INFO - '_': '/tools/buildbot/bin/python'} 14:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:30 INFO - Downloading/unpacking psutil>=3.1.1 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:37:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:32 INFO - Installing collected packages: psutil 14:37:32 INFO - Running setup.py install for psutil 14:37:32 INFO - building 'psutil._psutil_linux' extension 14:37:32 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 14:37:32 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 14:37:32 INFO - building 'psutil._psutil_posix' extension 14:37:32 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 14:37:32 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 14:37:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:32 INFO - Successfully installed psutil 14:37:32 INFO - Cleaning up... 14:37:33 INFO - Return code: 0 14:37:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:33 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 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37:33 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 14:37:33 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 14:37:33 INFO - Using env: {'DISPLAY': ':0', 14:37:33 INFO - 'HOME': '/home/cltbld', 14:37:33 INFO - 'LANG': 'en_US.UTF-8', 14:37:33 INFO - 'LANGUAGE': 'en_US:en', 14:37:33 INFO - 'LOGNAME': 'cltbld', 14:37:33 INFO - 'MAIL': '/var/mail/cltbld', 14:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:33 INFO - 'MOZ_NO_REMOTE': '1', 14:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:33 INFO - 'NO_EM_RESTART': '1', 14:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:33 INFO - 'PWD': '/builds/slave/test', 14:37:33 INFO - 'SHELL': '/bin/bash', 14:37:33 INFO - 'SHLVL': '1', 14:37:33 INFO - 'TERM': 'linux', 14:37:33 INFO - 'TMOUT': '86400', 14:37:33 INFO - 'USER': 'cltbld', 14:37:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:33 INFO - '_': '/tools/buildbot/bin/python'} 14:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:37:35 INFO - Installing collected packages: mozsystemmonitor 14:37:35 INFO - Running setup.py install for mozsystemmonitor 14:37:35 INFO - Successfully installed mozsystemmonitor 14:37:35 INFO - Cleaning up... 14:37:35 INFO - Return code: 0 14:37:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:35 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 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37:35 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 14:37:35 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 14:37:35 INFO - Using env: {'DISPLAY': ':0', 14:37:35 INFO - 'HOME': '/home/cltbld', 14:37:35 INFO - 'LANG': 'en_US.UTF-8', 14:37:35 INFO - 'LANGUAGE': 'en_US:en', 14:37:35 INFO - 'LOGNAME': 'cltbld', 14:37:35 INFO - 'MAIL': '/var/mail/cltbld', 14:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:35 INFO - 'MOZ_NO_REMOTE': '1', 14:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:35 INFO - 'NO_EM_RESTART': '1', 14:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:35 INFO - 'PWD': '/builds/slave/test', 14:37:35 INFO - 'SHELL': '/bin/bash', 14:37:35 INFO - 'SHLVL': '1', 14:37:35 INFO - 'TERM': 'linux', 14:37:35 INFO - 'TMOUT': '86400', 14:37:35 INFO - 'USER': 'cltbld', 14:37:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:35 INFO - '_': '/tools/buildbot/bin/python'} 14:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:35 INFO - Downloading/unpacking jsonschema==2.5.1 14:37:35 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 14:37:35 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 14:37:35 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 14:37:35 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 14:37:35 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 14:37:35 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 14:37:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:37:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:37:37 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 14:37:37 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 14:37:37 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 14:37:37 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 14:37:37 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 14:37:37 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 14:37:37 INFO - Downloading functools32-3.2.3-2.tar.gz 14:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:37:37 INFO - warning: no files found matching '*.txt' 14:37:37 INFO - no previously-included directories found matching 'build' 14:37:37 INFO - no previously-included directories found matching 'dist' 14:37:37 INFO - no previously-included directories found matching '.git*' 14:37:37 INFO - Installing collected packages: jsonschema, functools32 14:37:37 INFO - Running setup.py install for functools32 14:37:37 INFO - warning: no files found matching '*.txt' 14:37:37 INFO - no previously-included directories found matching 'build' 14:37:37 INFO - no previously-included directories found matching 'dist' 14:37:37 INFO - no previously-included directories found matching '.git*' 14:37:37 INFO - Successfully installed jsonschema functools32 14:37:37 INFO - Cleaning up... 14:37:37 INFO - Return code: 0 14:37:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:37:38 INFO - Using env: {'DISPLAY': ':0', 14:37:38 INFO - 'HOME': '/home/cltbld', 14:37:38 INFO - 'LANG': 'en_US.UTF-8', 14:37:38 INFO - 'LANGUAGE': 'en_US:en', 14:37:38 INFO - 'LOGNAME': 'cltbld', 14:37:38 INFO - 'MAIL': '/var/mail/cltbld', 14:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:38 INFO - 'MOZ_NO_REMOTE': '1', 14:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:38 INFO - 'NO_EM_RESTART': '1', 14:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:38 INFO - 'PWD': '/builds/slave/test', 14:37:38 INFO - 'SHELL': '/bin/bash', 14:37:38 INFO - 'SHLVL': '1', 14:37:38 INFO - 'TERM': 'linux', 14:37:38 INFO - 'TMOUT': '86400', 14:37:38 INFO - 'USER': 'cltbld', 14:37:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:38 INFO - '_': '/tools/buildbot/bin/python'} 14:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:37:38 INFO - Cleaning up... 14:37:38 INFO - Return code: 0 14:37:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:37:38 INFO - Using env: {'DISPLAY': ':0', 14:37:38 INFO - 'HOME': '/home/cltbld', 14:37:38 INFO - 'LANG': 'en_US.UTF-8', 14:37:38 INFO - 'LANGUAGE': 'en_US:en', 14:37:38 INFO - 'LOGNAME': 'cltbld', 14:37:38 INFO - 'MAIL': '/var/mail/cltbld', 14:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:38 INFO - 'MOZ_NO_REMOTE': '1', 14:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:38 INFO - 'NO_EM_RESTART': '1', 14:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:38 INFO - 'PWD': '/builds/slave/test', 14:37:38 INFO - 'SHELL': '/bin/bash', 14:37:38 INFO - 'SHLVL': '1', 14:37:38 INFO - 'TERM': 'linux', 14:37:38 INFO - 'TMOUT': '86400', 14:37:38 INFO - 'USER': 'cltbld', 14:37:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:38 INFO - '_': '/tools/buildbot/bin/python'} 14:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:38 INFO - Downloading/unpacking blobuploader==1.2.4 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:40 INFO - Downloading blobuploader-1.2.4.tar.gz 14:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:37:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:37:40 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 14:37:40 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 14:37:40 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 14:37:40 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 14:37:40 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 14:37:40 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 14:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:37:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:37:40 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 14:37:40 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 14:37:40 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 14:37:40 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 14:37:40 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 14:37:40 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 14:37:41 INFO - Downloading docopt-0.6.1.tar.gz 14:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:37:41 INFO - Installing collected packages: blobuploader, requests, docopt 14:37:41 INFO - Running setup.py install for blobuploader 14:37:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:37:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:37:41 INFO - Running setup.py install for requests 14:37:41 INFO - Running setup.py install for docopt 14:37:41 INFO - Successfully installed blobuploader requests docopt 14:37:41 INFO - Cleaning up... 14:37:41 INFO - Return code: 0 14:37:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:41 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 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37:41 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 14:37:41 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 14:37:41 INFO - Using env: {'DISPLAY': ':0', 14:37:41 INFO - 'HOME': '/home/cltbld', 14:37:41 INFO - 'LANG': 'en_US.UTF-8', 14:37:41 INFO - 'LANGUAGE': 'en_US:en', 14:37:41 INFO - 'LOGNAME': 'cltbld', 14:37:41 INFO - 'MAIL': '/var/mail/cltbld', 14:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:41 INFO - 'MOZ_NO_REMOTE': '1', 14:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:41 INFO - 'NO_EM_RESTART': '1', 14:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:41 INFO - 'PWD': '/builds/slave/test', 14:37:41 INFO - 'SHELL': '/bin/bash', 14:37:41 INFO - 'SHLVL': '1', 14:37:41 INFO - 'TERM': 'linux', 14:37:41 INFO - 'TMOUT': '86400', 14:37:41 INFO - 'USER': 'cltbld', 14:37:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:41 INFO - '_': '/tools/buildbot/bin/python'} 14:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:41 INFO - Running setup.py (path:/tmp/pip-e2Hv5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:42 INFO - Running setup.py (path:/tmp/pip-EMLLJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:42 INFO - Running setup.py (path:/tmp/pip-Pc1EHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:42 INFO - Running setup.py (path:/tmp/pip-0tnP9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:42 INFO - Running setup.py (path:/tmp/pip-gqoYio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:42 INFO - Running setup.py (path:/tmp/pip-uUxZxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:42 INFO - Running setup.py (path:/tmp/pip-w8YAl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:42 INFO - Running setup.py (path:/tmp/pip-ZHzWUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:42 INFO - Running setup.py (path:/tmp/pip-WwoWWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:42 INFO - Running setup.py (path:/tmp/pip-KRClju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:42 INFO - Running setup.py (path:/tmp/pip-MW1VIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:42 INFO - Running setup.py (path:/tmp/pip-d913qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:42 INFO - Running setup.py (path:/tmp/pip-LW1Row-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:42 INFO - Running setup.py (path:/tmp/pip-WHbIfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:42 INFO - Running setup.py (path:/tmp/pip-n3_MZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:43 INFO - Running setup.py (path:/tmp/pip-Tx070e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:43 INFO - Running setup.py (path:/tmp/pip-Lqy03a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:37:43 INFO - Running setup.py install for manifestparser 14:37:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:37:43 INFO - Running setup.py install for mozcrash 14:37:43 INFO - Running setup.py install for mozdebug 14:37:43 INFO - Running setup.py install for mozdevice 14:37:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:37:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:37:43 INFO - Running setup.py install for mozfile 14:37:43 INFO - Running setup.py install for mozhttpd 14:37:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:37:43 INFO - Running setup.py install for mozinfo 14:37:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:37:43 INFO - Running setup.py install for mozInstall 14:37:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:37:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:37:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:37:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:37:43 INFO - Running setup.py install for mozleak 14:37:44 INFO - Running setup.py install for mozlog 14:37:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:37:44 INFO - Running setup.py install for moznetwork 14:37:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:37:44 INFO - Running setup.py install for mozprocess 14:37:44 INFO - Running setup.py install for mozprofile 14:37:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:37:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:37:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:37:44 INFO - Running setup.py install for mozrunner 14:37:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:37:44 INFO - Running setup.py install for mozscreenshot 14:37:44 INFO - Running setup.py install for moztest 14:37:44 INFO - Running setup.py install for mozversion 14:37:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:37:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:37:44 INFO - Cleaning up... 14:37:44 INFO - Return code: 0 14:37:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:44 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')]} 14:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:44 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')]} 14:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:45 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 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37:45 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 14:37:45 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 14:37:45 INFO - Using env: {'DISPLAY': ':0', 14:37:45 INFO - 'HOME': '/home/cltbld', 14:37:45 INFO - 'LANG': 'en_US.UTF-8', 14:37:45 INFO - 'LANGUAGE': 'en_US:en', 14:37:45 INFO - 'LOGNAME': 'cltbld', 14:37:45 INFO - 'MAIL': '/var/mail/cltbld', 14:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:45 INFO - 'MOZ_NO_REMOTE': '1', 14:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:45 INFO - 'NO_EM_RESTART': '1', 14:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:45 INFO - 'PWD': '/builds/slave/test', 14:37:45 INFO - 'SHELL': '/bin/bash', 14:37:45 INFO - 'SHLVL': '1', 14:37:45 INFO - 'TERM': 'linux', 14:37:45 INFO - 'TMOUT': '86400', 14:37:45 INFO - 'USER': 'cltbld', 14:37:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:45 INFO - '_': '/tools/buildbot/bin/python'} 14:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:45 INFO - Running setup.py (path:/tmp/pip-3i8Qr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:45 INFO - Running setup.py (path:/tmp/pip-UHTcFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:45 INFO - Running setup.py (path:/tmp/pip-GSCnsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:45 INFO - Running setup.py (path:/tmp/pip-1jYfhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:45 INFO - Running setup.py (path:/tmp/pip-PunzLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:45 INFO - Running setup.py (path:/tmp/pip-JQknDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:45 INFO - Running setup.py (path:/tmp/pip-OhfkFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:45 INFO - Running setup.py (path:/tmp/pip-Qmytir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:45 INFO - Running setup.py (path:/tmp/pip-LWzGLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:45 INFO - Running setup.py (path:/tmp/pip-y0aXm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:45 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)) 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:45 INFO - Running setup.py (path:/tmp/pip-hz3mgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:46 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)) 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:46 INFO - Running setup.py (path:/tmp/pip-rawUxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:46 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)) 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:46 INFO - Running setup.py (path:/tmp/pip-PM5jMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:46 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)) 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:46 INFO - Running setup.py (path:/tmp/pip-kB_XQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:46 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)) 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:46 INFO - Running setup.py (path:/tmp/pip-xqQ_4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:46 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)) 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:46 INFO - Running setup.py (path:/tmp/pip-AME37I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:46 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)) 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:46 INFO - Running setup.py (path:/tmp/pip-14luFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:46 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)) 14:37:46 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)) 14:37:46 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)) 14:37:46 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)) 14:37:46 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)) 14:37:46 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)) 14:37:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:37:46 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 14:37:46 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 14:37:46 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 14:37:46 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 14:37:46 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 14:37:46 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 14:37:48 INFO - Downloading blessings-1.6.tar.gz 14:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:37:48 INFO - Installing collected packages: blessings 14:37:48 INFO - Running setup.py install for blessings 14:37:48 INFO - Successfully installed blessings 14:37:48 INFO - Cleaning up... 14:37:48 INFO - Return code: 0 14:37:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:37:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:48 INFO - Reading from file tmpfile_stdout 14:37:48 INFO - Current package versions: 14:37:48 INFO - argparse == 1.2.1 14:37:48 INFO - blessings == 1.6 14:37:48 INFO - blobuploader == 1.2.4 14:37:48 INFO - docopt == 0.6.1 14:37:48 INFO - functools32 == 3.2.3-2 14:37:48 INFO - jsonschema == 2.5.1 14:37:48 INFO - manifestparser == 1.1 14:37:48 INFO - mozInstall == 1.12 14:37:48 INFO - mozcrash == 1.0 14:37:48 INFO - mozdebug == 0.1 14:37:48 INFO - mozdevice == 0.48 14:37:48 INFO - mozfile == 1.2 14:37:48 INFO - mozhttpd == 0.7 14:37:48 INFO - mozinfo == 0.9 14:37:48 INFO - mozleak == 0.1 14:37:48 INFO - mozlog == 3.4 14:37:48 INFO - moznetwork == 0.27 14:37:48 INFO - mozprocess == 0.23 14:37:48 INFO - mozprofile == 0.28 14:37:48 INFO - mozrunner == 6.13 14:37:48 INFO - mozscreenshot == 0.1 14:37:48 INFO - mozsystemmonitor == 0.3 14:37:48 INFO - moztest == 0.7 14:37:48 INFO - mozversion == 1.4 14:37:48 INFO - psutil == 3.1.1 14:37:48 INFO - requests == 1.2.3 14:37:48 INFO - wsgiref == 0.1.2 14:37:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:48 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 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37:48 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 14:37:48 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 14:37:48 INFO - Using env: {'DISPLAY': ':0', 14:37:48 INFO - 'HOME': '/home/cltbld', 14:37:48 INFO - 'LANG': 'en_US.UTF-8', 14:37:48 INFO - 'LANGUAGE': 'en_US:en', 14:37:48 INFO - 'LOGNAME': 'cltbld', 14:37:48 INFO - 'MAIL': '/var/mail/cltbld', 14:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:48 INFO - 'MOZ_NO_REMOTE': '1', 14:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:48 INFO - 'NO_EM_RESTART': '1', 14:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:48 INFO - 'PWD': '/builds/slave/test', 14:37:48 INFO - 'SHELL': '/bin/bash', 14:37:48 INFO - 'SHLVL': '1', 14:37:48 INFO - 'TERM': 'linux', 14:37:48 INFO - 'TMOUT': '86400', 14:37:48 INFO - 'USER': 'cltbld', 14:37:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:48 INFO - '_': '/tools/buildbot/bin/python'} 14:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:49 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)) 14:37:49 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)) 14:37:49 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)) 14:37:49 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)) 14:37:49 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)) 14:37:49 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)) 14:37:49 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)) 14:37:49 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)) 14:37:49 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)) 14:37:49 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)) 14:37:49 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)) 14:37:49 INFO - Cleaning up... 14:37:49 INFO - Return code: 0 14:37:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:37:49 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')]} 14:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:49 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')]} 14:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:49 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 0x7fecd1a2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2165ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', '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 14:37:49 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 14:37:49 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 14:37:49 INFO - Using env: {'DISPLAY': ':0', 14:37:49 INFO - 'HOME': '/home/cltbld', 14:37:49 INFO - 'LANG': 'en_US.UTF-8', 14:37:49 INFO - 'LANGUAGE': 'en_US:en', 14:37:49 INFO - 'LOGNAME': 'cltbld', 14:37:49 INFO - 'MAIL': '/var/mail/cltbld', 14:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:49 INFO - 'MOZ_NO_REMOTE': '1', 14:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:49 INFO - 'NO_EM_RESTART': '1', 14:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:49 INFO - 'PWD': '/builds/slave/test', 14:37:49 INFO - 'SHELL': '/bin/bash', 14:37:49 INFO - 'SHLVL': '1', 14:37:49 INFO - 'TERM': 'linux', 14:37:49 INFO - 'TMOUT': '86400', 14:37:49 INFO - 'USER': 'cltbld', 14:37:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:49 INFO - '_': '/tools/buildbot/bin/python'} 14:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:37:49 INFO - Cleaning up... 14:37:49 INFO - Return code: 0 14:37:49 INFO - Running post-action listener: _resource_record_post_action 14:37:49 INFO - Running post-action listener: _start_resource_monitoring 14:37:49 INFO - Starting resource monitoring. 14:37:49 INFO - [mozharness: 2016-11-15 22:37:49.459547Z] Finished create-virtualenv step (success) 14:37:49 INFO - [mozharness: 2016-11-15 22:37:49.460002Z] Running install step. 14:37:49 INFO - Running pre-action listener: _resource_record_pre_action 14:37:49 INFO - Running main action method: install 14:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:49 INFO - Reading from file tmpfile_stdout 14:37:49 INFO - Detecting whether we're running mozinstall >=1.0... 14:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:37:49 INFO - Reading from file tmpfile_stdout 14:37:49 INFO - Output received: 14:37:49 INFO - Usage: mozinstall [options] installer 14:37:49 INFO - Options: 14:37:49 INFO - -h, --help show this help message and exit 14:37:49 INFO - -d DEST, --destination=DEST 14:37:49 INFO - Directory to install application into. [default: 14:37:49 INFO - "/builds/slave/test"] 14:37:49 INFO - --app=APP Application being installed. [default: firefox] 14:37:49 INFO - mkdir: /builds/slave/test/build/application 14:37:49 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'] 14:37:49 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 14:38:05 INFO - Reading from file tmpfile_stdout 14:38:05 INFO - Output received: 14:38:05 INFO - /builds/slave/test/build/application/firefox/firefox 14:38:05 INFO - Running post-action listener: _resource_record_post_action 14:38:05 INFO - [mozharness: 2016-11-15 22:38:05.663696Z] Finished install step (success) 14:38:05 INFO - [mozharness: 2016-11-15 22:38:05.663938Z] Running run-tests step. 14:38:05 INFO - Running pre-action listener: _resource_record_pre_action 14:38:05 INFO - Running main action method: run_tests 14:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:38:05 INFO - Python 2.7.3 14:38:05 INFO - Return code: 0 14:38:05 INFO - grabbing minidump binary from tooltool 14:38: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')]} 14:38:05 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 0x2162f60>, '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 0x2163d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21641d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:38:05 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 14:38:05 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 14:38:05 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 14:38:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:38:05 INFO - Return code: 0 14:38:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:38:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:38:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:38:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:38:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:38:05 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/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 14:38:05 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/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 14:38:05 INFO - Using env: {'DISPLAY': ':0', 14:38:05 INFO - 'HOME': '/home/cltbld', 14:38:05 INFO - 'LANG': 'en_US.UTF-8', 14:38:05 INFO - 'LANGUAGE': 'en_US:en', 14:38:05 INFO - 'LOGNAME': 'cltbld', 14:38:05 INFO - 'MAIL': '/var/mail/cltbld', 14:38:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:38:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:05 INFO - 'MOZ_NO_REMOTE': '1', 14:38:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:05 INFO - 'NO_EM_RESTART': '1', 14:38:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:05 INFO - 'PWD': '/builds/slave/test', 14:38:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:38:05 INFO - 'SHELL': '/bin/bash', 14:38:05 INFO - 'SHLVL': '1', 14:38:05 INFO - 'TERM': 'linux', 14:38:05 INFO - 'TMOUT': '86400', 14:38:05 INFO - 'USER': 'cltbld', 14:38:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032', 14:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:05 INFO - '_': '/tools/buildbot/bin/python'} 14:38:05 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/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 14:38:05 INFO - mozversion application_buildid: 20161115115349 14:38:05 INFO - mozversion application_changeset: 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 14:38:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:38:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:38:05 INFO - mozversion application_name: Firefox 14:38:05 INFO - mozversion application_remotingname: firefox-dev 14:38:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:38:05 INFO - mozversion application_vendor: Mozilla 14:38:05 INFO - mozversion application_version: 52.0a2 14:38:05 INFO - mozversion platform_buildid: 20161115115349 14:38:05 INFO - mozversion platform_changeset: 07f57a55ee1b4d5fb5655fd4c5a9094e2d8a0f09 14:38:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:38:05 INFO - mozversion platform_version: 52.0a2 14:38:05 INFO - using testdate: 1479249485 14:38:05 INFO - actual date: 1479249485 14:38:05 INFO - starting webserver on 'localhost:54284' 14:38:05 INFO - SUITE-START | Running 2 tests 14:38:05 INFO - TEST-START | dromaeo_css 14:38:05 INFO - operating with platform_type : linux_ 14:38:05 INFO - Initialising browser for dromaeo_css test... 14:38:05 INFO - TEST-INFO | started process 814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvr7Mm0/profile http://localhost:54284/getInfo.html) 14:38:09 ERROR - PROCESS | 814 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 14:38:10 INFO - PROCESS | 814 | __metrics Screen width/height:1600/1200 14:38:10 INFO - PROCESS | 814 | colorDepth:24 14:38:10 INFO - PROCESS | 814 | Browser inner width/height: 1024/697 14:38:10 INFO - PROCESS | 814 | __metrics 14:38:10 INFO - PROCESS | 814 | 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" 14:38:10 INFO - PROCESS | 814 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:38:11 INFO - PROCESS | 814 | console.error: PushService: 14:38:11 INFO - PROCESS | 814 | stateChangeProcessEnqueue: Error transitioning state 14:38:11 INFO - PROCESS | 814 | UnknownError 14:38:11 INFO - TEST-INFO | 814: exit 0 14:38:11 INFO - Browser initialized. 14:38:11 INFO - Running cycle 1/1 for dromaeo_css test... 14:38:11 INFO - TEST-INFO | started process 908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvr7Mm0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:23 INFO - PROCESS | 908 | RSS: Main: 144809984 14:38:23 INFO - PROCESS | 908 | 14:39:15 INFO - PROCESS | 908 | 1479249555370 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] 14:41:25 INFO - PROCESS | 908 | Cycle 1(1): loaded http://localhost:54284/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54284/tests/dromaeo/cssquery-ext.html) 14:41:26 INFO - PROCESS | 908 | RSS: Main: 245002240 14:41:26 INFO - PROCESS | 908 | 14:44:29 INFO - PROCESS | 908 | Cycle 1(1): loaded http://localhost:54284/tests/dromaeo/cssquery-ext.html (next: http://localhost:54284/tests/dromaeo/cssquery-jquery.html) 14:44:29 INFO - PROCESS | 908 | RSS: Main: 234475520 14:44:29 INFO - PROCESS | 908 | 14:47:31 INFO - PROCESS | 908 | Cycle 1(1): loaded http://localhost:54284/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54284/tests/dromaeo/cssquery-mootools.html) 14:47:32 INFO - PROCESS | 908 | RSS: Main: 213790720 14:47:32 INFO - PROCESS | 908 | 14:50:34 INFO - PROCESS | 908 | Cycle 1(1): loaded http://localhost:54284/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54284/tests/dromaeo/cssquery-prototype.html) 14:50:34 INFO - PROCESS | 908 | RSS: Main: 214511616 14:50:34 INFO - PROCESS | 908 | 14:53:37 INFO - PROCESS | 908 | Cycle 1(1): loaded http://localhost:54284/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54284/tests/dromaeo/cssquery-yui.html) 14:53:37 INFO - PROCESS | 908 | RSS: Main: 169861120 14:53:37 INFO - PROCESS | 908 | 14:56:40 INFO - PROCESS | 908 | Cycle 1(1): loaded http://localhost:54284/tests/dromaeo/cssquery-yui.html (next: http://localhost:54284/tests/dromaeo/cssquery-dojo.html) 14:56:40 INFO - PROCESS | 908 | RSS: Main: 264015872 14:56:40 INFO - PROCESS | 908 | 14:56:40 INFO - PROCESS | 908 | __start_tp_report 14:56:40 INFO - PROCESS | 908 | _x_x_mozilla_page_load 14:56:40 INFO - PROCESS | 908 | _x_x_mozilla_page_load_details 14:56:40 INFO - PROCESS | 908 | |i|pagename|runs| 14:56:40 INFO - PROCESS | 908 | |0;dojo.html;3287.80273183609;3300.0269512182945;3325.168707823043;3334.6331903490627;3368.528406023157;5507.504324610784;5565.526930210926;5567.248421463101;5586.888262234753;5606.495415412612;5609.915851262224;5663.235463212465;5663.9433605663935;5670.574706896979;5684.062129748597;5055.418626857912;5091.567216786559;5118.232265160219;5143.717095559743;5187.533122019017;4923.458419573844;4944.554990050895;5182.067227898996;5186.273921650972;5195.922061169066;5000.374953130859;5014.097462456756;5040.6471546991725;5134.306868572732;5170.896582068356;5187.533122019017;5205.869853253642;5251.186066159751;5257.5005374489365;5283.603729720248;4909.558139767402;5149.356330458692;5167.870803229912;5203.895922081575;5213.218017297398;5502.0371434999115;5503.2020357048405;5503.3395992480755;5522.199281104217;5540.944590554083;5947.583669143161;5950.077737950624;6057.848553786191;6058.4244496772735;6060.424259695322;5906.645601263895;6088.178095957033;6099.085137229406;6108.053251745987;6108.236470441195;5543.057680194376;5576.749046292886;5638.802641907513;5644.717764111778;5658.886822263532;6198.969005154945;6199.101130336076;6205.03821907596;6205.441510264098;6215.564910456224;5798.5071268941765;5985.850353741192;5989.401059894063;5997.730102145327;5998.220231369981;5924.911126333109;5977.22296101504;6038.396160384014;6050;6115.179495343419;6061.3029501607;6069.544784141119;6077.574569780161;6089.665068421279;6104.755809767648;6020;6076.240469941257;6080.300765411946;6083.330833608299;6085.421884920926;4530.478994915561;4544.7727613619845;4555.726656400627;4557.270836666117;4559.133764584718;4113.876583702494;4121.793910304473;4124.793760311973;4129.525104612948;4139.855105071308;5705.771769129271;5706.600537962386;5707.286589176353;5707.486326230576;5709.65742055478;5866.2373891393845;5924.940750592439;5996.820095397145;6044.607100538451;6059.394060593905;5869.442402971711;5876.177335173079;5884.411558844081;5898.380670029671;5929.436703513159;5276.182191760283;5277.076511610529;5284.313039304866;5287.23335116406;5289.18017707256;6120.599512025131;6135.967692822179;6361.077643741632;6408.1669382980845;6429.517786166056;6022.849428764316;6051.546134039877;6056.697165141637;6116.66358350295;6143.078538219303;6345.650989195638;6381.617102973836;6387.201599800025;6392.3927226913365;6395.040743888454;5814.505767009851;5961.254843144607;6018.548608854266;6021.096835474714;6030.30651475086;5933.169356290209;5948.315943666361;5987.670678112571;5991.041433370639;6090.025595904811;5861.706914654335;5891.1457838614015;5904.261967254093;5913.733881975236;5916.911246331222;5890.204822349099;5896.262967129109;5897.085951677497;5897.852553686193;5901.350851406256;5709.7430615623225;5821.039528477923;5824.592278540631;5829.5336373090895;5847.766089356378;6020.397960203944;6037.09443583466;6043.758249669964;6049.062395328731;6053.697315134314;5745.540356771365;5782.074868021096;5876.3536011037895;5877.059670452707;5887.852803679771 14:56:40 INFO - PROCESS | 908 | |1;ext.html;587.4272584230376;627.4948666323609;649.9935000649992;661.3551787007672;673.4746897420014;33977.1505712357;37047.0738231544;45866.54133458665;46535.767321163345;46609.300860487034;47913.76043119788;48271.75864120675;48380.27429588559;48452.27321590179;48469.27296090561;8918.687845925393;9073.41022833517;9074.319426043041;9078.455292682427;9081;8844.38089333747;8931.464112153259;8935.59789809457;8938.86591701125;8941.910580894173;8850.380473366868;8926.2412694921;8927.41971771836;8930.86603700945;8933.330000249975;8872.556372181365;8886.466811991237;8929.285657147413;8934.64261429542;8937.240334571568;8613;8839.116088391174;8839.46963182211;8854.86717699235;8899;44976.77511612454;45418.772906135586;45494.31758523625;45498.54501454976;45509.544904550865;3705.925881482355;3919.941200881989;3960.841566337343;4058.715889887709;4396.670249731251;33849.153771155674;34120;34541;34656.306873862384;35975;4470.173017991682;4553.979894610435;4594.341538812147;4600.9769951150365;4605.014238206168;372038;372693;374807;375094.1245293783;375917;63191;63199;63403.365966340665;63633.68183159055;63726.362736372044;40513.36663116888;41440;41464.1707165861;67701.3229867695;67771.32228677749;19594.804051959298;19799.802001980082;19834.206631734858;19853.106610202576;19857.60284794325;15058.774118388234;15295.464658737113;15375.846241537442;15377;15385.307661155051;21326.36020919375;21496.89251553732;21506.354809355744;21519.354419367442;21617.243396481048;7414.777556673308;7433.962830185815;7579.5073320235115;7831.6867325307485;7873.637908627504;1001.6944831826363;1036.7045392063226;1046.6232156423682;1110.4336788237895;1172.0799172649429;33367.3326533468;33402.83298583492;33636.831815840764;33682.66317336795;33896;808.9797755056053;1115.743379022813;1124.8706398764248;1136.4772204785727;1147.0651419093413;16520;17836.643267134583;17910.91044544769;17985.370512032277;18037;519776;520982;524142;524532;528568;63818.36181638124;64305;64387.67806160939;64404.35595644077;64479.35520644827;1314.6910476038124;1384.3216823756488;1407.8451370349253;1442.740306744796;1446.2840893757448;32388.35223295568;34158.14604634904;34875.30249394947;34884.30231395307;34967.12582185466;53537.19694204512;54221.45778542164;54354;54357.18464222961;54396;378191;380143;380918;380934;662438;44148;44382.3342649854;44401.33397998968;44641.55358446374;44826.55173448354;50041;50640;50741.23888141755;50970.980580388925;51263.23105153351;42254.577454226295;42500.78749606232;42686.14627707366;43254.351184732885;43995.34006989962;42338.15323693571;42469.787651061546;42960.35559466548;43984.34023489714;44260.557394426934;41943.7902810484;42606.1478770429;43173.78413107914;43275;43386.349204761325;35612.465813012306;37287.81356093311;37852.43221351737;38539;38648.42027369648;27711.168664940084;28149.577756333263;28224.576631350956;28294.292642684097;28331 14:56:40 INFO - PROCESS | 908 | |2;jquery.html;397.0649121319295;434.83897992360414;436.6724956282788;437.10611798871304;442.4999750282183;16776.328946842128;20465.079071441804;20469.385918422453;21114.472138196514;21671.566568668655;20736.585268294624;20771.584568308626;20790;20897.164113435483;21056.99999999996;5094.6433749637545;5582.023145949453;5982.910256346158;6014.578979471439;6018.638881667092;5775.422457754233;5869.589128760988;5969.5821292509545;5987.6108052976415;5990.850228744294;5934.821955341346;5954.910676339837;5962.522998160159;5965.433283838051;5966.045432730764;5731.598788084836;5936.792212272593;5948.107783832438;5951.166836642873;5951.375105613914;5869.413058694139;5874.706264686749;5877.52979761618;5879.029960056629;5879.970600146972;14197.432102715879;14765.630859228499;22699.751513666743;23110.42223944398;23342.64986025211;2370.3718514593647;2403.735589085199;2418.2140804238516;2763.4473105379006;3053.2366908272934;10195.643152489702;10288.485575721184;10473.214508911786;10871.402072885989;11107.500162492708;1942.786293507713;1967.1639553189837;2008.437637461513;2020.7170996060563;2094.2565389286738;82825;87524.5623771877;87870;89494;90669;11949.402529873472;12024;12038.578649747216;12092.576759813364;12381.690457738629;17114.315427383015;17153.970761754335;17179.656406872044;17179.656406872044;17187.05471199096;8628;8923;8953.462792232487;9043.276537876955;9211.539423028957;8627.568621568897;8688.11100599179;8775.210231079234;8869.556522173865;9139.223166030828;4970.179920313108;5175.378954525406;5264.368275806851;5265.526102650703;5302.443243459381;2012.1649515451218;2098.7376577927757;2138.775428580008;2161.978380216178;2173.1636766931915;969.762408209979;1000.9749756256006;1006.8187726209206;1027.2809033676308;1063.197286049028;19523.902380488005;19622.21511139567;20057.699134512994;20143.0935607898;20681.172753089708;987.4124895687055;993.056596233581;1040.9271351005357;1060.522764755863;1080.0333701337258;10476.842847357144;10910.399928003877;11200.887991119984;11269.09847212221;11273.041791447655;457628;460000;488669;529830;532861;92944;93641.5317923406;94206;94388.52805735928;94605;1019.7858449725493;1023.6673081248624;1027.429776474064;1047.711879233217;1052.5158427123608;17202.483925482255;17692.69281674278;17935.461936141935;17939.461816145016;18081.81918180854;43136.78431607947;43346.78326608347;44416.55583444124;44518.77740611406;44621;56998.7150064247;59989;61493.38506614877;62276.37723622706;62537;8769.816074829816;8809.207171354352;8896.065913079034;8947.150020748019;8949.239314658067;10287.794244115226;12758.170718903242;13439.596812095653;13791.10357826738;14125.576232713034;11797.29216247028;11918;12202.755944880875;12205.328706921204;12730.936345318214;11230.606928757454;12028.338441385808;12118.333491658044;12253.75492490163;12435.440405181607;12263.632091037283;12502.312372819582;12534.811977820158;12715.93642031784;13140.211587304791;9036.45781253127;9159.816803663756;9176.08239176077;9236.815263694554;9537.713868583953;9845.507724613597;12775.936120319338;12793.104482686123;12798.872011279767;12927.353632318158 14:56:40 INFO - PROCESS | 908 | |3;mootools.html;1243.676644072542;1528.7171873203458;1540.6995635851006;1715.742638604209;1858.0988220712943;7771.417143714223;8400.537970411626;8715.302775777931;8747.081556436578;9000.504972226525;8765.211130998208;8861.64553417864;8895.110488951103;8922.821543569125;8929.151730585583;2487.8009759219262;2516.245126462063;2518.106072344319;2521.0798058708624;2522;2380.785729284364;2515.76100270474;2516.4338023944647;2520.042383894127;2526.2547548473244;2443.315871555967;2443.7922776564014;2444.2545023767743;2455.472073504205;2455.8649274289905;2365.550545396378;2390.8087353011806;2426.7573242675767;2430.368104292879;2440.1947357372023;2391.5814732421754;2408.8193385496156;2432.027189124347;2432.1730611591965;2466.7903228225623;8529.53087580183;8597.527136007517;8609.655613775441;8734.825303493959;8735.1701588349;5368.516833485005;5461.508464238238;5463.672179669233;5492.203630473559;5502.504774570268;3424.828758562087;3589.353916295066;3600.6399360063783;3642.3990041643096;3649.543807024122;1162.5756598841447;1189.4469071881617;1193.0336427493758;1198.7602479504135;1267.2903174222465;12139.757204855854;12251.264924104582;12326.691832704164;12370.19593726414;12372.75254494914;4397.560243975577;4607.101615185007;4648.511906249795;4741.454732705783;4754.358161648202;9668.033196680275;9691.27315451344;9703.708888733348;9706.466144362128;9758.024197580186;5373.328333958255;5377.623566350318;5382.031234377771;5385.3268341457315;5385.649932754359;4350.825966961349;4528.818847246139;4633.768311584475;5045.545900868866;5055.974720126449;3802.6957843372466;3901.921961560753;3937.8818635440985;3990.082281075369;3992.0818211811447;1224.7183147876037;1249.7562975219926;1253.6051143889645;1257.126297223421;1265.0322503284995;899.4153800030033;1013.9594416223268;1033.7674023344687;1036.1814166808288;1039.9948000260101;5834.15404766315;6123.173371594778;6193.783217587453;6253.999360102362;6298;494.77487743076813;503.4788993391822;989.3322007644811;1057.1595581512715;1080.0711388206137;3986.9202615948097;3998.4002399639703;4027.7583344998807;4030.3954406839207;4168.062186008124;10537.209709271836;10918.945405272923;10959.945200273947;10997.725056873642;10999.285046471954;10843.67468975932;10890.564377424973;10896.346219226873;10905.509252083675;10923.890761092287;8231.135730748305;8272.545010024507;8444.155584441507;8446.788830279293;8446.915530844735;5945.851353716192;6004.718207081456;6078.57449978515;6105.8168254952425;6181.938180618136;9968.352057116264;10009.449480278654;10012.549435275576;10027.197824174194;10147.34042287249;10080.949595251977;10248.948755256177;10270.897291027293;10352.120069794151;10367.481625918825;7498.362639175732;7562.508436951581;7571.734989275349;7609.086909570887;7637.236276372319;8376.874346884924;8377.623006964579;8423.031351394668;8434.24091831738;8445.493270403795;7722.806929826799;7739.458237923292;7795.4543181976715;7809.92190078092;7923.20767923203;7534.510256833289;7542.509736867086;7576.090869095523;7620.695172193272;7729.3430058445665;6989.615571143636;7029.226785053742;7078.469114816512;7112.6088065154845;7122.786316410516;4946.604271658187;5111.744412779421;5147.665401749025;5192.350956130484;5256.500632439912;4942.085714142895;5103.617228707788;5117;5133.845984620468;5388.865278368072 14:56:40 INFO - PROCESS | 908 | |4;prototype.html;331.8158422075747;347.7461453139208;347.746145313921;353.04325278495276;354.3409258778671;5332.240360680976;5339.145736682131;5380.273663055486;5395.2446657467935;5443.700596467198;4989;5124.436312005686;5128.307678463407;5134.589232861372;5299.873074885817;4159.23054234966;4164.812583433738;4166.583341665824;4198.454200953872;4207.284761590522;4193.329067349225;4204.600562946515;4207.705460617743;4218.493780746315;4230.302000169968;4077.1234184650293;4154.356074808409;4166.749995000295;4169.874903752877;4190.979045104786;4165.854195103157;4174;4177.039280965365;4177.644900183488;4186.518550366686;3692.6307369263127;3722.7766334019775;3730.2166545025575;3743.1765011697385;3747.7376583639157;4948.883374689826;5138.922916156261;5165.405978312505;5169.534741873212;5169.974150129263;4770.61835053195;4798.5441383068555;4805.519448055202;4813.638977076698;4831.758412079382;5486.271824375349;5486.561075113981;5496.835094947118;5505.889882202334;5522.834314970557;4038.8788336349958;4125.628693417607;4133.483314585676;4138.79306034697;4141.5237247716595;5634.1830434586755;5662.17898404729;5670.3479099903625;5693.259876216065;5695.430456954271;4168.499780026416;4169.3120635094865;4182.665386769051;4184.225918205142;4197.874063778091;4101.979490102531;4267.935980960288;4275.700700950966;4281.828726850953;4294.527601963781;4719.693219940762;4732.337472753818;4734.147853386424;4750.12122757291;4764.737939413296;5497.47773961473;5511.862203444946;5522.116461366162;5532.5573954083575;5552.91670624941;1369.4795977528674;1419.32582023538;1424.7649137892338;1424.8646378594017;1435.9282035898163;951.3958636266021;1003.8092762375271;1009.6869970309227;1026.3328836256344;1031.3244824639874;5165.302684137669;5168.3539557555305;5184.8185313514605;5249.370075590953;5255;5469.617126801086;5475.233467314579;5477.561795056386;5495.368032676213;5536.916946245809;5204.21936709489;5478.397376288684;5491.697956612345;5498.780048798003;5508.697021663847;2884.7163012459255;2895.739383455499;2895.753860921803;2899.811077458274;2911.9563206551493;5539.637058261719;5610.186522954149;5674.921764864663;5732.627379220337;5741.62679425836;5517.641353312022;5528.253685752372;5548.69482178484;5584.86037849057;5588.692621905753;5707.029804933089;5715.199872017921;5725.799597014085;5734.684592347461;5741.339745929272;5400.595845080229;5528.087865502308;5644.3508996465935;5701.971490142523;5717.628354156966;5578.804741834017;5628.183913332626;5632.802851900164;5636.267285252891;5644.435556444487;5678.20505129274;5896.115582662635;5911.7930872420975;5927;5967.582269241111;4081.6734661227624;4131.380292956081;4139.379093136054;4139.648129908871;4144.41978123057;5701.600887937804;5710.457506536873;5714.257146570919;5717.371089180104;5738.426157384228;5394.433584473731;5538.390777014606;5540.612157148961;5623.522000629992;5624.550035997192;5539.14143307788;5555.083496193806;5564.554835613222;5576.470235327637;5579.77680892776;5283.233931079895;5436.646617969819;5442.945570544244;5506.2291279221745;5548.528375088163;5160.93562574958;5484.643498172606;5551.666899986014;5571;5580.748866301107;5459.781608735765;5468.753906074316;5474;5476.288082549243;5485.314335708036 14:56:40 INFO - PROCESS | 908 | |5;yui.html;714.792710114067;752.4695089961576;777.7588947426299;831.7047448155904;878.0517041595078;14290.857091429083;15461.149636769973;15507.302171402273;16432.17839108046;17155.485335439924;16599.751003734924;16720.498385048468;16764.41324553641;16771.748423773624;16777.412790552302;738.184306341493;759.2028370211284;851.1573542193215;851.9190676885702;874.2568816505983;840.995795021024;855.589317127779;856.3662889461816;857.0272740439615;857.2028013947026;916.0793402630347;917.0691747875911;918.42598376015;918.6279556779515;918.7886786039215;763.1300317637897;787.3386355461382;910.8588168833842;911.9133682300204;912.7079334612894;629.1192330736959;645.2225068792094;645.9321771214002;647.252423450915;651.9869602607921;15149;15225.847741522664;15798.289076991448;15807.130607816565;15823.208839557976;14236.430542778277;14531.709365812625;14572.854271457256;14718.779218311734;14744.631384215374;12884.420201090974;12967.416466259041;13134.014948878777;13165.1442656228;13802.17186968775;3878.2243551289853;4007.479027726406;4432.335149727534;4495.123450927071;4522.389477420539;63894;64029.35970640281;64190.358096419375;64256.67871660612;65272.3472765271;11907.940460297816;11908.88091119095;11989.460474278678;11991.520339186334;12169.69575760613;21108.577828443653;21131.577368452545;21142.47143821386;21293;21330.89334553317;8470;8509.106543812934;8516.446430981967;8713.215810576952;8728.476291422536;4704.835330763407;4755.667103302736;4786.1863483207935;4890;4903.362562866804;3764.604716504782;3844.75009124406;3884.902877428087;3890.2608504384075;3906.062544989239;625.4996003197424;633.4299130782333;638.7157714816955;639.4085470939362;656.7701304543467;642.3127253838442;750.7860259825924;759.525296689569;771.1786946901644;793.1988691421706;9193.862092068624;9744;9769.804603907882;9871.309008369346;9999;668.9598624082571;676.3067855448205;725.2783480436999;730.7150211417552;741.4253953186324;4573.428321459817;4707.5057119002695;4822.565969062731;4831.4685384607665;4910;83785.58107209425;85387.5730621343;85503.57248213718;85526.57236713776;88196;77824.22175778283;78949;79053.20946790573;79613.20386796058;81213;70233;70865.2913470869;71046.64476677583;71064.64467677628;74207;9186.54067296646;9456.2907781918;9472.668456603986;9527.428354298765;9527.821277776655;47733;48201.96022570995;48424.27363589619;49180.508194917595;49789.004219916125;64112.67943660438;64184.35815641784;65547.34452655412;65701;65988.67005664941;12346.880991883241;12753.234805911676;12767.489300427878;12794.360281985677;13141.802872957105;13134.343282836011;13146.80279795823;13299;13358.666033349244;13494.93252533731;12532.874671253536;12641.747165056831;12687;13258.867411325764;13279.40242689062;12206.389680515762;12304.81542776877;12443.688907777378;12903.548375806802;13085.542006029744;11612.477438515456;11961.820572691591;11978.880211198126;12434.253944763343;12552.874471255536;10042.849357259793;10079.24405669563;10204.540795664065;10241.641542545975;10397.42814145199;10874;10954.671359859218;11024.952629500185;11154.721131971766;11191.384473854016 14:56:40 INFO - PROCESS | 908 | __end_tp_report 14:56:40 INFO - PROCESS | 908 | __start_cc_report 14:56:40 INFO - PROCESS | 908 | _x_x_mozilla_cycle_collect,1065 14:56:40 INFO - PROCESS | 908 | __end_cc_report 14:56:40 INFO - PROCESS | 908 | __startTimestamp1479250600656__endTimestamp 14:56:40 INFO - PROCESS | 908 | 14:56:40 INFO - PROCESS | 908 | ------- Summary: start ------- 14:56:40 INFO - PROCESS | 908 | Number of tests: 6 14:56:40 INFO - PROCESS | 908 | 14:56:40 INFO - PROCESS | 908 | [#0] dojo.html Cycles:165 Average:5619.54 Median:5876.18 stddev:644.09 (11.0%) stddev-sans-first:619.55 14:56:40 INFO - PROCESS | 908 | Values: 3287.8 3300.0 3325.2 3334.6 3368.5 5507.5 5565.5 5567.2 5586.9 5606.5 5609.9 5663.2 5663.9 5670.6 5684.1 5055.4 5091.6 5118.2 5143.7 5187.5 4923.5 4944.6 5182.1 5186.3 5195.9 5000.4 5014.1 5040.6 5134.3 5170.9 5187.5 5205.9 5251.2 5257.5 5283.6 4909.6 5149.4 5167.9 5203.9 5213.2 5502.0 5503.2 5503.3 5522.2 5540.9 5947.6 5950.1 6057.8 6058.4 6060.4 5906.6 6088.2 6099.1 6108.1 6108.2 5543.1 5576.7 5638.8 5644.7 5658.9 6199.0 6199.1 6205.0 6205.4 6215.6 5798.5 5985.9 5989.4 5997.7 5998.2 5924.9 5977.2 6038.4 6050.0 6115.2 6061.3 6069.5 6077.6 6089.7 6104.8 6020.0 6076.2 6080.3 6083.3 6085.4 4530.5 4544.8 4555.7 4557.3 4559.1 4113.9 4121.8 4124.8 4129.5 4139.9 5705.8 5706.6 5707.3 5707.5 5709.7 5866.2 5924.9 5996.8 6044.6 6059.4 5869.4 5876.2 5884.4 5898.4 5929.4 5276.2 5277.1 5284.3 5287.2 5289.2 6120.6 6136.0 6361.1 6408.2 6429.5 6022.8 6051.5 6056.7 6116.7 6143.1 6345.7 6381.6 6387.2 6392.4 6395.0 5814.5 5961.3 6018.5 6021.1 6030.3 5933.2 5948.3 5987.7 5991.0 6090.0 5861.7 5891.1 5904.3 5913.7 5916.9 5890.2 5896.3 5897.1 5897.9 5901.4 5709.7 5821.0 5824.6 5829.5 5847.8 6020.4 6037.1 6043.8 6049.1 6053.7 5745.5 5782.1 5876.4 5877.1 5887.9 14:56:40 INFO - PROCESS | 908 | 14:56:40 INFO - PROCESS | 908 | [#1] ext.html Cycles:180 Average:62089.84 Median:43989.84 stddev:120112.95 (273.0%) stddev-sans-first:120361.13 14:56:40 INFO - PROCESS | 908 | Values: 587.4 627.5 650.0 661.4 673.5 33977.2 37047.1 45866.5 46535.8 46609.3 47913.8 48271.8 48380.3 48452.3 48469.3 8918.7 9073.4 9074.3 9078.5 9081.0 8844.4 8931.5 8935.6 8938.9 8941.9 8850.4 8926.2 8927.4 8930.9 8933.3 8872.6 8886.5 8929.3 8934.6 8937.2 8613.0 8839.1 8839.5 8854.9 8899.0 44976.8 45418.8 45494.3 45498.5 45509.5 3705.9 3919.9 3960.8 4058.7 4396.7 33849.2 34120.0 34541.0 34656.3 35975.0 4470.2 4554.0 4594.3 4601.0 4605.0 372038.0 372693.0 374807.0 375094.1 375917.0 63191.0 63199.0 63403.4 63633.7 63726.4 40513.4 41440.0 41464.2 67701.3 67771.3 19594.8 19799.8 19834.2 19853.1 19857.6 15058.8 15295.5 15375.8 15377.0 15385.3 21326.4 21496.9 21506.4 21519.4 21617.2 7414.8 7434.0 7579.5 7831.7 7873.6 1001.7 1036.7 1046.6 1110.4 1172.1 33367.3 33402.8 33636.8 33682.7 33896.0 809.0 1115.7 1124.9 1136.5 1147.1 16520.0 17836.6 17910.9 17985.4 18037.0 519776.0 520982.0 524142.0 524532.0 528568.0 63818.4 64305.0 64387.7 64404.4 64479.4 1314.7 1384.3 1407.8 1442.7 1446.3 32388.4 34158.1 34875.3 34884.3 34967.1 53537.2 54221.5 54354.0 54357.2 54396.0 378191.0 380143.0 380918.0 380934.0 662438.0 44148.0 44382.3 44401.3 44641.6 44826.6 50041.0 50640.0 50741.2 50971.0 51263.2 42254.6 42500.8 42686.1 43254.4 43995.3 42338.2 42469.8 42960.4 43984.3 44260.6 41943.8 42606.1 43173.8 43275.0 43386.3 35612.5 37287.8 37852.4 38539.0 38648.4 27711.2 28149.6 28224.6 28294.3 28331.0 14:56:40 INFO - PROCESS | 908 | 14:56:40 INFO - PROCESS | 908 | [#2] jquery.html Cycles:180 Average:29776.25 Median:12856.51 stddev:81718.36 (635.6%) stddev-sans-first:81917.83 14:56:40 INFO - PROCESS | 908 | Values: 397.1 434.8 436.7 437.1 442.5 16776.3 20465.1 20469.4 21114.5 21671.6 20736.6 20771.6 20790.0 20897.2 21057.0 5094.6 5582.0 5982.9 6014.6 6018.6 5775.4 5869.6 5969.6 5987.6 5990.9 5934.8 5954.9 5962.5 5965.4 5966.0 5731.6 5936.8 5948.1 5951.2 5951.4 5869.4 5874.7 5877.5 5879.0 5880.0 14197.4 14765.6 22699.8 23110.4 23342.6 2370.4 2403.7 2418.2 2763.4 3053.2 10195.6 10288.5 10473.2 10871.4 11107.5 1942.8 1967.2 2008.4 2020.7 2094.3 82825.0 87524.6 87870.0 89494.0 90669.0 11949.4 12024.0 12038.6 12092.6 12381.7 17114.3 17154.0 17179.7 17179.7 17187.1 8628.0 8923.0 8953.5 9043.3 9211.5 8627.6 8688.1 8775.2 8869.6 9139.2 4970.2 5175.4 5264.4 5265.5 5302.4 2012.2 2098.7 2138.8 2162.0 2173.2 969.8 1001.0 1006.8 1027.3 1063.2 19523.9 19622.2 20057.7 20143.1 20681.2 987.4 993.1 1040.9 1060.5 1080.0 10476.8 10910.4 11200.9 11269.1 11273.0 457628.0 460000.0 488669.0 529830.0 532861.0 92944.0 93641.5 94206.0 94388.5 94605.0 1019.8 1023.7 1027.4 1047.7 1052.5 17202.5 17692.7 17935.5 17939.5 18081.8 43136.8 43346.8 44416.6 44518.8 44621.0 56998.7 59989.0 61493.4 62276.4 62537.0 8769.8 8809.2 8896.1 8947.2 8949.2 10287.8 12758.2 13439.6 13791.1 14125.6 11797.3 11918.0 12202.8 12205.3 12730.9 11230.6 12028.3 12118.3 12253.8 12435.4 12263.6 12502.3 12534.8 12715.9 13140.2 9036.5 9159.8 9176.1 9236.8 9537.7 9845.5 12775.9 12793.1 12798.9 12927.4 14:56:40 INFO - PROCESS | 908 | 14:56:40 INFO - PROCESS | 908 | [#3] mootools.html Cycles:180 Average:5813.75 Median:4694.98 stddev:3243.54 (69.1%) stddev-sans-first:3234.45 14:56:40 INFO - PROCESS | 908 | Values: 1243.7 1528.7 1540.7 1715.7 1858.1 7771.4 8400.5 8715.3 8747.1 9000.5 8765.2 8861.6 8895.1 8922.8 8929.2 2487.8 2516.2 2518.1 2521.1 2522.0 2380.8 2515.8 2516.4 2520.0 2526.3 2443.3 2443.8 2444.3 2455.5 2455.9 2365.6 2390.8 2426.8 2430.4 2440.2 2391.6 2408.8 2432.0 2432.2 2466.8 8529.5 8597.5 8609.7 8734.8 8735.2 5368.5 5461.5 5463.7 5492.2 5502.5 3424.8 3589.4 3600.6 3642.4 3649.5 1162.6 1189.4 1193.0 1198.8 1267.3 12139.8 12251.3 12326.7 12370.2 12372.8 4397.6 4607.1 4648.5 4741.5 4754.4 9668.0 9691.3 9703.7 9706.5 9758.0 5373.3 5377.6 5382.0 5385.3 5385.6 4350.8 4528.8 4633.8 5045.5 5056.0 3802.7 3901.9 3937.9 3990.1 3992.1 1224.7 1249.8 1253.6 1257.1 1265.0 899.4 1014.0 1033.8 1036.2 1040.0 5834.2 6123.2 6193.8 6254.0 6298.0 494.8 503.5 989.3 1057.2 1080.1 3986.9 3998.4 4027.8 4030.4 4168.1 10537.2 10918.9 10959.9 10997.7 10999.3 10843.7 10890.6 10896.3 10905.5 10923.9 8231.1 8272.5 8444.2 8446.8 8446.9 5945.9 6004.7 6078.6 6105.8 6181.9 9968.4 10009.4 10012.5 10027.2 10147.3 10080.9 10248.9 10270.9 10352.1 10367.5 7498.4 7562.5 7571.7 7609.1 7637.2 8376.9 8377.6 8423.0 8434.2 8445.5 7722.8 7739.5 7795.5 7809.9 7923.2 7534.5 7542.5 7576.1 7620.7 7729.3 6989.6 7029.2 7078.5 7112.6 7122.8 4946.6 5111.7 5147.7 5192.4 5256.5 4942.1 5103.6 5117.0 5133.8 5388.9 14:56:40 INFO - PROCESS | 908 | 14:56:40 INFO - PROCESS | 908 | [#4] prototype.html Cycles:180 Average:4667.40 Median:5291.55 stddev:1341.27 (25.3%) stddev-sans-first:1304.96 14:56:40 INFO - PROCESS | 908 | Values: 331.8 347.7 347.7 353.0 354.3 5332.2 5339.1 5380.3 5395.2 5443.7 4989.0 5124.4 5128.3 5134.6 5299.9 4159.2 4164.8 4166.6 4198.5 4207.3 4193.3 4204.6 4207.7 4218.5 4230.3 4077.1 4154.4 4166.7 4169.9 4191.0 4165.9 4174.0 4177.0 4177.6 4186.5 3692.6 3722.8 3730.2 3743.2 3747.7 4948.9 5138.9 5165.4 5169.5 5170.0 4770.6 4798.5 4805.5 4813.6 4831.8 5486.3 5486.6 5496.8 5505.9 5522.8 4038.9 4125.6 4133.5 4138.8 4141.5 5634.2 5662.2 5670.3 5693.3 5695.4 4168.5 4169.3 4182.7 4184.2 4197.9 4102.0 4267.9 4275.7 4281.8 4294.5 4719.7 4732.3 4734.1 4750.1 4764.7 5497.5 5511.9 5522.1 5532.6 5552.9 1369.5 1419.3 1424.8 1424.9 1435.9 951.4 1003.8 1009.7 1026.3 1031.3 5165.3 5168.4 5184.8 5249.4 5255.0 5469.6 5475.2 5477.6 5495.4 5536.9 5204.2 5478.4 5491.7 5498.8 5508.7 2884.7 2895.7 2895.8 2899.8 2912.0 5539.6 5610.2 5674.9 5732.6 5741.6 5517.6 5528.3 5548.7 5584.9 5588.7 5707.0 5715.2 5725.8 5734.7 5741.3 5400.6 5528.1 5644.4 5702.0 5717.6 5578.8 5628.2 5632.8 5636.3 5644.4 5678.2 5896.1 5911.8 5927.0 5967.6 4081.7 4131.4 4139.4 4139.6 4144.4 5701.6 5710.5 5714.3 5717.4 5738.4 5394.4 5538.4 5540.6 5623.5 5624.6 5539.1 5555.1 5564.6 5576.5 5579.8 5283.2 5436.6 5442.9 5506.2 5548.5 5160.9 5484.6 5551.7 5571.0 5580.7 5459.8 5468.8 5474.0 5476.3 5485.3 14:56:40 INFO - PROCESS | 908 | 14:56:40 INFO - PROCESS | 908 | [#5] yui.html Cycles:180 Average:18357.33 Median:4896.68 stddev:23926.12 (488.6%) stddev-sans-first:23956.57 14:56:40 INFO - PROCESS | 908 | Values: 714.8 752.5 777.8 831.7 878.1 14290.9 15461.1 15507.3 16432.2 17155.5 16599.8 16720.5 16764.4 16771.7 16777.4 738.2 759.2 851.2 851.9 874.3 841.0 855.6 856.4 857.0 857.2 916.1 917.1 918.4 918.6 918.8 763.1 787.3 910.9 911.9 912.7 629.1 645.2 645.9 647.3 652.0 15149.0 15225.8 15798.3 15807.1 15823.2 14236.4 14531.7 14572.9 14718.8 14744.6 12884.4 12967.4 13134.0 13165.1 13802.2 3878.2 4007.5 4432.3 4495.1 4522.4 63894.0 64029.4 64190.4 64256.7 65272.3 11907.9 11908.9 11989.5 11991.5 12169.7 21108.6 21131.6 21142.5 21293.0 21330.9 8470.0 8509.1 8516.4 8713.2 8728.5 4704.8 4755.7 4786.2 4890.0 4903.4 3764.6 3844.8 3884.9 3890.3 3906.1 625.5 633.4 638.7 639.4 656.8 642.3 750.8 759.5 771.2 793.2 9193.9 9744.0 9769.8 9871.3 9999.0 669.0 676.3 725.3 730.7 741.4 4573.4 4707.5 4822.6 4831.5 4910.0 83785.6 85387.6 85503.6 85526.6 88196.0 77824.2 78949.0 79053.2 79613.2 81213.0 70233.0 70865.3 71046.6 71064.6 74207.0 9186.5 9456.3 9472.7 9527.4 9527.8 47733.0 48202.0 48424.3 49180.5 49789.0 64112.7 64184.4 65547.3 65701.0 65988.7 12346.9 12753.2 12767.5 12794.4 13141.8 13134.3 13146.8 13299.0 13358.7 13494.9 12532.9 12641.7 12687.0 13258.9 13279.4 12206.4 12304.8 12443.7 12903.5 13085.5 11612.5 11961.8 11978.9 12434.3 12552.9 10042.8 10079.2 10204.5 10241.6 10397.4 10874.0 10954.7 11025.0 11154.7 11191.4 14:56:40 INFO - PROCESS | 908 | -------- Summary: end -------- 14:56:40 INFO - PROCESS | 908 | 14:56:41 INFO - TEST-INFO | 908: exit 0 14:56:41 INFO - TEST-OK | dromaeo_css | took 1115507ms 14:56:41 INFO - TEST-START | kraken 14:56:41 INFO - operating with platform_type : linux_ 14:56:41 INFO - Initialising browser for kraken test... 14:56:41 INFO - TEST-INFO | started process 1305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsRuA3J/profile http://localhost:54284/getInfo.html) 14:56:44 ERROR - PROCESS | 1305 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 14:56:45 INFO - PROCESS | 1305 | __metrics Screen width/height:1600/1200 14:56:45 INFO - PROCESS | 1305 | colorDepth:24 14:56:45 INFO - PROCESS | 1305 | Browser inner width/height: 1024/697 14:56:45 INFO - PROCESS | 1305 | __metrics 14:56:45 INFO - PROCESS | 1305 | 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" 14:56:45 INFO - PROCESS | 1305 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:56:46 INFO - PROCESS | 1305 | console.error: PushService: 14:56:46 INFO - PROCESS | 1305 | stateChangeProcessEnqueue: Error transitioning state 14:56:46 INFO - PROCESS | 1305 | UnknownError 14:56:46 INFO - TEST-INFO | 1305: exit 0 14:56:46 INFO - Browser initialized. 14:56:46 INFO - Running cycle 1/1 for kraken test... 14:56:46 INFO - TEST-INFO | started process 1397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsRuA3J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:56:58 INFO - PROCESS | 1397 | RSS: Main: 144257024 14:56:58 INFO - PROCESS | 1397 | 14:57:01 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54284/tests/kraken/driver.html?testName=audio-beat-detection) 14:57:02 INFO - PROCESS | 1397 | RSS: Main: 186208256 14:57:02 INFO - PROCESS | 1397 | 14:57:04 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54284/tests/kraken/driver.html?testName=audio-dft) 14:57:05 INFO - PROCESS | 1397 | RSS: Main: 175964160 14:57:05 INFO - PROCESS | 1397 | 14:57:07 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54284/tests/kraken/driver.html?testName=audio-fft) 14:57:08 INFO - PROCESS | 1397 | RSS: Main: 266596352 14:57:08 INFO - PROCESS | 1397 | 14:57:10 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54284/tests/kraken/driver.html?testName=audio-oscillator) 14:57:11 INFO - PROCESS | 1397 | RSS: Main: 172900352 14:57:11 INFO - PROCESS | 1397 | 14:57:13 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54284/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:57:13 INFO - PROCESS | 1397 | RSS: Main: 175394816 14:57:13 INFO - PROCESS | 1397 | 14:57:16 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54284/tests/kraken/driver.html?testName=imaging-darkroom) 14:57:17 INFO - PROCESS | 1397 | RSS: Main: 214646784 14:57:17 INFO - PROCESS | 1397 | 14:57:20 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54284/tests/kraken/driver.html?testName=imaging-desaturate) 14:57:21 INFO - PROCESS | 1397 | RSS: Main: 213110784 14:57:21 INFO - PROCESS | 1397 | 14:57:24 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54284/tests/kraken/driver.html?testName=json-parse-financial) 14:57:24 INFO - PROCESS | 1397 | RSS: Main: 211431424 14:57:24 INFO - PROCESS | 1397 | 14:57:26 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54284/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:57:26 INFO - PROCESS | 1397 | RSS: Main: 173584384 14:57:26 INFO - PROCESS | 1397 | 14:57:28 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54284/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:57:28 INFO - PROCESS | 1397 | RSS: Main: 181334016 14:57:28 INFO - PROCESS | 1397 | 14:57:30 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54284/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:57:31 INFO - PROCESS | 1397 | RSS: Main: 190627840 14:57:31 INFO - PROCESS | 1397 | 14:57:34 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:57:34 INFO - PROCESS | 1397 | RSS: Main: 198361088 14:57:34 INFO - PROCESS | 1397 | 14:57:37 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:57:38 INFO - PROCESS | 1397 | RSS: Main: 194916352 14:57:38 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | Cycle 1(1): loaded http://localhost:54284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54284/tests/kraken/driver.html?testName=ai-astar) 14:57:39 INFO - PROCESS | 1397 | RSS: Main: 247111680 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | __start_tp_report 14:57:39 INFO - PROCESS | 1397 | _x_x_mozilla_page_load 14:57:39 INFO - PROCESS | 1397 | _x_x_mozilla_page_load_details 14:57:39 INFO - PROCESS | 1397 | |i|pagename|runs| 14:57:39 INFO - PROCESS | 1397 | |0;ai-astar;111;116;113;114;114;113;113;115;114;114 14:57:39 INFO - PROCESS | 1397 | |1;audio-beat-detection;144;120;127;159;129;127;122;123;154;125 14:57:39 INFO - PROCESS | 1397 | |2;audio-dft;160;161;160;161;160;160;161;160;161;160 14:57:39 INFO - PROCESS | 1397 | |3;audio-fft;74;73;74;118;75;76;75;76;96;76 14:57:39 INFO - PROCESS | 1397 | |4;audio-oscillator;83;81;108;82;82;82;99;82;83;113 14:57:39 INFO - PROCESS | 1397 | |5;imaging-gaussian-blur;116;117;126;116;116;116;117;117;117;117 14:57:39 INFO - PROCESS | 1397 | |6;imaging-darkroom;145;146;146;145;145;146;145;147;146;146 14:57:39 INFO - PROCESS | 1397 | |7;imaging-desaturate;85;85;84;84;85;85;84;84;85;84 14:57:39 INFO - PROCESS | 1397 | |8;json-parse-financial;50;50;50;50;50;49;53;50;50;49 14:57:39 INFO - PROCESS | 1397 | |9;json-stringify-tinderbox;61;59;60;60;60;60;60;61;61;60 14:57:39 INFO - PROCESS | 1397 | |10;stanford-crypto-aes;74;74;77;74;75;75;74;75;74;80 14:57:39 INFO - PROCESS | 1397 | |11;stanford-crypto-ccm;130;127;129;127;127;128;128;125;164;125 14:57:39 INFO - PROCESS | 1397 | |12;stanford-crypto-pbkdf2;154;155;157;158;151;157;152;158;152;159 14:57:39 INFO - PROCESS | 1397 | |13;stanford-crypto-sha256-iterative;61;61;61;62;65;61;61;61;60;62 14:57:39 INFO - PROCESS | 1397 | __end_tp_report 14:57:39 INFO - PROCESS | 1397 | __start_cc_report 14:57:39 INFO - PROCESS | 1397 | _x_x_mozilla_cycle_collect,1632 14:57:39 INFO - PROCESS | 1397 | __end_cc_report 14:57:39 INFO - PROCESS | 1397 | __startTimestamp1479250659928__endTimestamp 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | ------- Summary: start ------- 14:57:39 INFO - PROCESS | 1397 | Number of tests: 14 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.00 14:57:39 INFO - PROCESS | 1397 | Values: 111.0 116.0 113.0 114.0 114.0 113.0 113.0 115.0 114.0 114.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:128.00 stddev:14.06 (11.0%) stddev-sans-first:14.34 14:57:39 INFO - PROCESS | 1397 | Values: 144.0 120.0 127.0 159.0 129.0 127.0 122.0 123.0 154.0 125.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 14:57:39 INFO - PROCESS | 1397 | Values: 160.0 161.0 160.0 161.0 160.0 160.0 161.0 160.0 161.0 160.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:14.54 (19.3%) stddev-sans-first:15.18 14:57:39 INFO - PROCESS | 1397 | Values: 74.0 73.0 74.0 118.0 75.0 76.0 75.0 76.0 96.0 76.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:82.00 stddev:12.32 (15.0%) stddev-sans-first:12.84 14:57:39 INFO - PROCESS | 1397 | Values: 83.0 81.0 108.0 82.0 82.0 82.0 99.0 82.0 83.0 113.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:3.03 (2.6%) stddev-sans-first:3.16 14:57:39 INFO - PROCESS | 1397 | Values: 116.0 117.0 126.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 14:57:39 INFO - PROCESS | 1397 | Values: 145.0 146.0 146.0 145.0 145.0 146.0 145.0 147.0 146.0 146.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:57:39 INFO - PROCESS | 1397 | Values: 85.0 85.0 84.0 84.0 85.0 85.0 84.0 84.0 85.0 84.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:1.10 (2.2%) stddev-sans-first:1.17 14:57:39 INFO - PROCESS | 1397 | Values: 50.0 50.0 50.0 50.0 50.0 49.0 53.0 50.0 50.0 49.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 14:57:39 INFO - PROCESS | 1397 | Values: 61.0 59.0 60.0 60.0 60.0 60.0 60.0 61.0 61.0 60.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:1.93 (2.6%) stddev-sans-first:2.00 14:57:39 INFO - PROCESS | 1397 | Values: 74.0 74.0 77.0 74.0 75.0 75.0 74.0 75.0 74.0 80.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:128.00 stddev:11.70 (9.1%) stddev-sans-first:12.40 14:57:39 INFO - PROCESS | 1397 | Values: 130.0 127.0 129.0 127.0 127.0 128.0 128.0 125.0 164.0 125.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:157.00 stddev:2.91 (1.9%) stddev-sans-first:3.05 14:57:39 INFO - PROCESS | 1397 | Values: 154.0 155.0 157.0 158.0 151.0 157.0 152.0 158.0 152.0 159.0 14:57:39 INFO - PROCESS | 1397 | 14:57:39 INFO - PROCESS | 1397 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 14:57:39 INFO - PROCESS | 1397 | Values: 61.0 61.0 61.0 62.0 65.0 61.0 61.0 61.0 60.0 62.0 14:57:39 INFO - PROCESS | 1397 | -------- Summary: end -------- 14:57:39 INFO - PROCESS | 1397 | 14:57:40 INFO - TEST-INFO | 1397: exit 0 14:57:40 INFO - TEST-OK | kraken | took 59527ms 14:57:40 INFO - SUITE-END | took 1175s 14:57:41 INFO - Completed test suite (00:19:35) 14:57:41 INFO - javascript benchmark 14:57:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.80273183609, 3300.0269512182945, 3325.168707823043, 3334.6331903490627, 3368.528406023157, 5507.504324610784, 5565.526930210926, 5567.248421463101, 5586.888262234753, 5606.495415412612, 5609.915851262224, 5663.235463212465, 5663.9433605663935, 5670.574706896979, 5684.062129748597, 5055.418626857912, 5091.567216786559, 5118.232265160219, 5143.717095559743, 5187.533122019017, 4923.458419573844, 4944.554990050895, 5182.067227898996, 5186.273921650972, 5195.922061169066, 5000.374953130859, 5014.097462456756, 5040.6471546991725, 5134.306868572732, 5170.896582068356, 5187.533122019017, 5205.869853253642, 5251.186066159751, 5257.5005374489365, 5283.603729720248, 4909.558139767402, 5149.356330458692, 5167.870803229912, 5203.895922081575, 5213.218017297398, 5502.0371434999115, 5503.2020357048405, 5503.3395992480755, 5522.199281104217, 5540.944590554083, 5947.583669143161, 5950.077737950624, 6057.848553786191, 6058.4244496772735, 6060.424259695322, 5906.645601263895, 6088.178095957033, 6099.085137229406, 6108.053251745987, 6108.236470441195, 5543.057680194376, 5576.749046292886, 5638.802641907513, 5644.717764111778, 5658.886822263532, 6198.969005154945, 6199.101130336076, 6205.03821907596, 6205.441510264098, 6215.564910456224, 5798.5071268941765, 5985.850353741192, 5989.401059894063, 5997.730102145327, 5998.220231369981, 5924.911126333109, 5977.22296101504, 6038.396160384014, 6050.0, 6115.179495343419, 6061.3029501607, 6069.544784141119, 6077.574569780161, 6089.665068421279, 6104.755809767648, 6020.0, 6076.240469941257, 6080.300765411946, 6083.330833608299, 6085.421884920926, 4530.478994915561, 4544.7727613619845, 4555.726656400627, 4557.270836666117, 4559.133764584718, 4113.876583702494, 4121.793910304473, 4124.793760311973, 4129.525104612948, 4139.855105071308, 5705.771769129271, 5706.600537962386, 5707.286589176353, 5707.486326230576, 5709.65742055478, 5866.2373891393845, 5924.940750592439, 5996.820095397145, 6044.607100538451, 6059.394060593905, 5869.442402971711, 5876.177335173079, 5884.411558844081, 5898.380670029671, 5929.436703513159, 5276.182191760283, 5277.076511610529, 5284.313039304866, 5287.23335116406, 5289.18017707256, 6120.599512025131, 6135.967692822179, 6361.077643741632, 6408.1669382980845, 6429.517786166056, 6022.849428764316, 6051.546134039877, 6056.697165141637, 6116.66358350295, 6143.078538219303, 6345.650989195638, 6381.617102973836, 6387.201599800025, 6392.3927226913365, 6395.040743888454, 5814.505767009851, 5961.254843144607, 6018.548608854266, 6021.096835474714, 6030.30651475086, 5933.169356290209, 5948.315943666361, 5987.670678112571, 5991.041433370639, 6090.025595904811, 5861.706914654335, 5891.1457838614015, 5904.261967254093, 5913.733881975236, 5916.911246331222, 5890.204822349099, 5896.262967129109, 5897.085951677497, 5897.852553686193, 5901.350851406256, 5709.7430615623225, 5821.039528477923, 5824.592278540631, 5829.5336373090895, 5847.766089356378, 6020.397960203944, 6037.09443583466, 6043.758249669964, 6049.062395328731, 6053.697315134314, 5745.540356771365, 5782.074868021096, 5876.3536011037895, 5877.059670452707, 5887.852803679771], "value": 5576.167512171489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.4272584230376, 627.4948666323609, 649.9935000649992, 661.3551787007672, 673.4746897420014, 33977.1505712357, 37047.0738231544, 45866.54133458665, 46535.767321163345, 46609.300860487034, 47913.76043119788, 48271.75864120675, 48380.27429588559, 48452.27321590179, 48469.27296090561, 8918.687845925393, 9073.41022833517, 9074.319426043041, 9078.455292682427, 9081.0, 8844.38089333747, 8931.464112153259, 8935.59789809457, 8938.86591701125, 8941.910580894173, 8850.380473366868, 8926.2412694921, 8927.41971771836, 8930.86603700945, 8933.330000249975, 8872.556372181365, 8886.466811991237, 8929.285657147413, 8934.64261429542, 8937.240334571568, 8613.0, 8839.116088391174, 8839.46963182211, 8854.86717699235, 8899.0, 44976.77511612454, 45418.772906135586, 45494.31758523625, 45498.54501454976, 45509.544904550865, 3705.925881482355, 3919.941200881989, 3960.841566337343, 4058.715889887709, 4396.670249731251, 33849.153771155674, 34120.0, 34541.0, 34656.306873862384, 35975.0, 4470.173017991682, 4553.979894610435, 4594.341538812147, 4600.9769951150365, 4605.014238206168, 372038.0, 372693.0, 374807.0, 375094.1245293783, 375917.0, 63191.0, 63199.0, 63403.365966340665, 63633.68183159055, 63726.362736372044, 40513.36663116888, 41440.0, 41464.1707165861, 67701.3229867695, 67771.32228677749, 19594.804051959298, 19799.802001980082, 19834.206631734858, 19853.106610202576, 19857.60284794325, 15058.774118388234, 15295.464658737113, 15375.846241537442, 15377.0, 15385.307661155051, 21326.36020919375, 21496.89251553732, 21506.354809355744, 21519.354419367442, 21617.243396481048, 7414.777556673308, 7433.962830185815, 7579.5073320235115, 7831.6867325307485, 7873.637908627504, 1001.6944831826363, 1036.7045392063226, 1046.6232156423682, 1110.4336788237895, 1172.0799172649429, 33367.3326533468, 33402.83298583492, 33636.831815840764, 33682.66317336795, 33896.0, 808.9797755056053, 1115.743379022813, 1124.8706398764248, 1136.4772204785727, 1147.0651419093413, 16520.0, 17836.643267134583, 17910.91044544769, 17985.370512032277, 18037.0, 519776.0, 520982.0, 524142.0, 524532.0, 528568.0, 63818.36181638124, 64305.0, 64387.67806160939, 64404.35595644077, 64479.35520644827, 1314.6910476038124, 1384.3216823756488, 1407.8451370349253, 1442.740306744796, 1446.2840893757448, 32388.35223295568, 34158.14604634904, 34875.30249394947, 34884.30231395307, 34967.12582185466, 53537.19694204512, 54221.45778542164, 54354.0, 54357.18464222961, 54396.0, 378191.0, 380143.0, 380918.0, 380934.0, 662438.0, 44148.0, 44382.3342649854, 44401.33397998968, 44641.55358446374, 44826.55173448354, 50041.0, 50640.0, 50741.23888141755, 50970.980580388925, 51263.23105153351, 42254.577454226295, 42500.78749606232, 42686.14627707366, 43254.351184732885, 43995.34006989962, 42338.15323693571, 42469.787651061546, 42960.35559466548, 43984.34023489714, 44260.557394426934, 41943.7902810484, 42606.1478770429, 43173.78413107914, 43275.0, 43386.349204761325, 35612.465813012306, 37287.81356093311, 37852.43221351737, 38539.0, 38648.42027369648, 27711.168664940084, 28149.577756333263, 28224.576631350956, 28294.292642684097, 28331.0], "value": 21274.13626359551, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.0649121319295, 434.83897992360414, 436.6724956282788, 437.10611798871304, 442.4999750282183, 16776.328946842128, 20465.079071441804, 20469.385918422453, 21114.472138196514, 21671.566568668655, 20736.585268294624, 20771.584568308626, 20790.0, 20897.164113435483, 21056.99999999996, 5094.6433749637545, 5582.023145949453, 5982.910256346158, 6014.578979471439, 6018.638881667092, 5775.422457754233, 5869.589128760988, 5969.5821292509545, 5987.6108052976415, 5990.850228744294, 5934.821955341346, 5954.910676339837, 5962.522998160159, 5965.433283838051, 5966.045432730764, 5731.598788084836, 5936.792212272593, 5948.107783832438, 5951.166836642873, 5951.375105613914, 5869.413058694139, 5874.706264686749, 5877.52979761618, 5879.029960056629, 5879.970600146972, 14197.432102715879, 14765.630859228499, 22699.751513666743, 23110.42223944398, 23342.64986025211, 2370.3718514593647, 2403.735589085199, 2418.2140804238516, 2763.4473105379006, 3053.2366908272934, 10195.643152489702, 10288.485575721184, 10473.214508911786, 10871.402072885989, 11107.500162492708, 1942.786293507713, 1967.1639553189837, 2008.437637461513, 2020.7170996060563, 2094.2565389286738, 82825.0, 87524.5623771877, 87870.0, 89494.0, 90669.0, 11949.402529873472, 12024.0, 12038.578649747216, 12092.576759813364, 12381.690457738629, 17114.315427383015, 17153.970761754335, 17179.656406872044, 17179.656406872044, 17187.05471199096, 8628.0, 8923.0, 8953.462792232487, 9043.276537876955, 9211.539423028957, 8627.568621568897, 8688.11100599179, 8775.210231079234, 8869.556522173865, 9139.223166030828, 4970.179920313108, 5175.378954525406, 5264.368275806851, 5265.526102650703, 5302.443243459381, 2012.1649515451218, 2098.7376577927757, 2138.775428580008, 2161.978380216178, 2173.1636766931915, 969.762408209979, 1000.9749756256006, 1006.8187726209206, 1027.2809033676308, 1063.197286049028, 19523.902380488005, 19622.21511139567, 20057.699134512994, 20143.0935607898, 20681.172753089708, 987.4124895687055, 993.056596233581, 1040.9271351005357, 1060.522764755863, 1080.0333701337258, 10476.842847357144, 10910.399928003877, 11200.887991119984, 11269.09847212221, 11273.041791447655, 457628.0, 460000.0, 488669.0, 529830.0, 532861.0, 92944.0, 93641.5317923406, 94206.0, 94388.52805735928, 94605.0, 1019.7858449725493, 1023.6673081248624, 1027.429776474064, 1047.711879233217, 1052.5158427123608, 17202.483925482255, 17692.69281674278, 17935.461936141935, 17939.461816145016, 18081.81918180854, 43136.78431607947, 43346.78326608347, 44416.55583444124, 44518.77740611406, 44621.0, 56998.7150064247, 59989.0, 61493.38506614877, 62276.37723622706, 62537.0, 8769.816074829816, 8809.207171354352, 8896.065913079034, 8947.150020748019, 8949.239314658067, 10287.794244115226, 12758.170718903242, 13439.596812095653, 13791.10357826738, 14125.576232713034, 11797.29216247028, 11918.0, 12202.755944880875, 12205.328706921204, 12730.936345318214, 11230.606928757454, 12028.338441385808, 12118.333491658044, 12253.75492490163, 12435.440405181607, 12263.632091037283, 12502.312372819582, 12534.811977820158, 12715.93642031784, 13140.211587304791, 9036.45781253127, 9159.816803663756, 9176.08239176077, 9236.815263694554, 9537.713868583953, 9845.507724613597, 12775.936120319338, 12793.104482686123, 12798.872011279767, 12927.353632318158], "value": 9645.521344518873, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.676644072542, 1528.7171873203458, 1540.6995635851006, 1715.742638604209, 1858.0988220712943, 7771.417143714223, 8400.537970411626, 8715.302775777931, 8747.081556436578, 9000.504972226525, 8765.211130998208, 8861.64553417864, 8895.110488951103, 8922.821543569125, 8929.151730585583, 2487.8009759219262, 2516.245126462063, 2518.106072344319, 2521.0798058708624, 2522.0, 2380.785729284364, 2515.76100270474, 2516.4338023944647, 2520.042383894127, 2526.2547548473244, 2443.315871555967, 2443.7922776564014, 2444.2545023767743, 2455.472073504205, 2455.8649274289905, 2365.550545396378, 2390.8087353011806, 2426.7573242675767, 2430.368104292879, 2440.1947357372023, 2391.5814732421754, 2408.8193385496156, 2432.027189124347, 2432.1730611591965, 2466.7903228225623, 8529.53087580183, 8597.527136007517, 8609.655613775441, 8734.825303493959, 8735.1701588349, 5368.516833485005, 5461.508464238238, 5463.672179669233, 5492.203630473559, 5502.504774570268, 3424.828758562087, 3589.353916295066, 3600.6399360063783, 3642.3990041643096, 3649.543807024122, 1162.5756598841447, 1189.4469071881617, 1193.0336427493758, 1198.7602479504135, 1267.2903174222465, 12139.757204855854, 12251.264924104582, 12326.691832704164, 12370.19593726414, 12372.75254494914, 4397.560243975577, 4607.101615185007, 4648.511906249795, 4741.454732705783, 4754.358161648202, 9668.033196680275, 9691.27315451344, 9703.708888733348, 9706.466144362128, 9758.024197580186, 5373.328333958255, 5377.623566350318, 5382.031234377771, 5385.3268341457315, 5385.649932754359, 4350.825966961349, 4528.818847246139, 4633.768311584475, 5045.545900868866, 5055.974720126449, 3802.6957843372466, 3901.921961560753, 3937.8818635440985, 3990.082281075369, 3992.0818211811447, 1224.7183147876037, 1249.7562975219926, 1253.6051143889645, 1257.126297223421, 1265.0322503284995, 899.4153800030033, 1013.9594416223268, 1033.7674023344687, 1036.1814166808288, 1039.9948000260101, 5834.15404766315, 6123.173371594778, 6193.783217587453, 6253.999360102362, 6298.0, 494.77487743076813, 503.4788993391822, 989.3322007644811, 1057.1595581512715, 1080.0711388206137, 3986.9202615948097, 3998.4002399639703, 4027.7583344998807, 4030.3954406839207, 4168.062186008124, 10537.209709271836, 10918.945405272923, 10959.945200273947, 10997.725056873642, 10999.285046471954, 10843.67468975932, 10890.564377424973, 10896.346219226873, 10905.509252083675, 10923.890761092287, 8231.135730748305, 8272.545010024507, 8444.155584441507, 8446.788830279293, 8446.915530844735, 5945.851353716192, 6004.718207081456, 6078.57449978515, 6105.8168254952425, 6181.938180618136, 9968.352057116264, 10009.449480278654, 10012.549435275576, 10027.197824174194, 10147.34042287249, 10080.949595251977, 10248.948755256177, 10270.897291027293, 10352.120069794151, 10367.481625918825, 7498.362639175732, 7562.508436951581, 7571.734989275349, 7609.086909570887, 7637.236276372319, 8376.874346884924, 8377.623006964579, 8423.031351394668, 8434.24091831738, 8445.493270403795, 7722.806929826799, 7739.458237923292, 7795.4543181976715, 7809.92190078092, 7923.20767923203, 7534.510256833289, 7542.509736867086, 7576.090869095523, 7620.695172193272, 7729.3430058445665, 6989.615571143636, 7029.226785053742, 7078.469114816512, 7112.6088065154845, 7122.786316410516, 4946.604271658187, 5111.744412779421, 5147.665401749025, 5192.350956130484, 5256.500632439912, 4942.085714142895, 5103.617228707788, 5117.0, 5133.845984620468, 5388.865278368072], "value": 4680.038257042809, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.8158422075747, 347.7461453139208, 347.746145313921, 353.04325278495276, 354.3409258778671, 5332.240360680976, 5339.145736682131, 5380.273663055486, 5395.2446657467935, 5443.700596467198, 4989.0, 5124.436312005686, 5128.307678463407, 5134.589232861372, 5299.873074885817, 4159.23054234966, 4164.812583433738, 4166.583341665824, 4198.454200953872, 4207.284761590522, 4193.329067349225, 4204.600562946515, 4207.705460617743, 4218.493780746315, 4230.302000169968, 4077.1234184650293, 4154.356074808409, 4166.749995000295, 4169.874903752877, 4190.979045104786, 4165.854195103157, 4174.0, 4177.039280965365, 4177.644900183488, 4186.518550366686, 3692.6307369263127, 3722.7766334019775, 3730.2166545025575, 3743.1765011697385, 3747.7376583639157, 4948.883374689826, 5138.922916156261, 5165.405978312505, 5169.534741873212, 5169.974150129263, 4770.61835053195, 4798.5441383068555, 4805.519448055202, 4813.638977076698, 4831.758412079382, 5486.271824375349, 5486.561075113981, 5496.835094947118, 5505.889882202334, 5522.834314970557, 4038.8788336349958, 4125.628693417607, 4133.483314585676, 4138.79306034697, 4141.5237247716595, 5634.1830434586755, 5662.17898404729, 5670.3479099903625, 5693.259876216065, 5695.430456954271, 4168.499780026416, 4169.3120635094865, 4182.665386769051, 4184.225918205142, 4197.874063778091, 4101.979490102531, 4267.935980960288, 4275.700700950966, 4281.828726850953, 4294.527601963781, 4719.693219940762, 4732.337472753818, 4734.147853386424, 4750.12122757291, 4764.737939413296, 5497.47773961473, 5511.862203444946, 5522.116461366162, 5532.5573954083575, 5552.91670624941, 1369.4795977528674, 1419.32582023538, 1424.7649137892338, 1424.8646378594017, 1435.9282035898163, 951.3958636266021, 1003.8092762375271, 1009.6869970309227, 1026.3328836256344, 1031.3244824639874, 5165.302684137669, 5168.3539557555305, 5184.8185313514605, 5249.370075590953, 5255.0, 5469.617126801086, 5475.233467314579, 5477.561795056386, 5495.368032676213, 5536.916946245809, 5204.21936709489, 5478.397376288684, 5491.697956612345, 5498.780048798003, 5508.697021663847, 2884.7163012459255, 2895.739383455499, 2895.753860921803, 2899.811077458274, 2911.9563206551493, 5539.637058261719, 5610.186522954149, 5674.921764864663, 5732.627379220337, 5741.62679425836, 5517.641353312022, 5528.253685752372, 5548.69482178484, 5584.86037849057, 5588.692621905753, 5707.029804933089, 5715.199872017921, 5725.799597014085, 5734.684592347461, 5741.339745929272, 5400.595845080229, 5528.087865502308, 5644.3508996465935, 5701.971490142523, 5717.628354156966, 5578.804741834017, 5628.183913332626, 5632.802851900164, 5636.267285252891, 5644.435556444487, 5678.20505129274, 5896.115582662635, 5911.7930872420975, 5927.0, 5967.582269241111, 4081.6734661227624, 4131.380292956081, 4139.379093136054, 4139.648129908871, 4144.41978123057, 5701.600887937804, 5710.457506536873, 5714.257146570919, 5717.371089180104, 5738.426157384228, 5394.433584473731, 5538.390777014606, 5540.612157148961, 5623.522000629992, 5624.550035997192, 5539.14143307788, 5555.083496193806, 5564.554835613222, 5576.470235327637, 5579.77680892776, 5283.233931079895, 5436.646617969819, 5442.945570544244, 5506.2291279221745, 5548.528375088163, 5160.93562574958, 5484.643498172606, 5551.666899986014, 5571.0, 5580.748866301107, 5459.781608735765, 5468.753906074316, 5474.0, 5476.288082549243, 5485.314335708036], "value": 4245.98844681747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.792710114067, 752.4695089961576, 777.7588947426299, 831.7047448155904, 878.0517041595078, 14290.857091429083, 15461.149636769973, 15507.302171402273, 16432.17839108046, 17155.485335439924, 16599.751003734924, 16720.498385048468, 16764.41324553641, 16771.748423773624, 16777.412790552302, 738.184306341493, 759.2028370211284, 851.1573542193215, 851.9190676885702, 874.2568816505983, 840.995795021024, 855.589317127779, 856.3662889461816, 857.0272740439615, 857.2028013947026, 916.0793402630347, 917.0691747875911, 918.42598376015, 918.6279556779515, 918.7886786039215, 763.1300317637897, 787.3386355461382, 910.8588168833842, 911.9133682300204, 912.7079334612894, 629.1192330736959, 645.2225068792094, 645.9321771214002, 647.252423450915, 651.9869602607921, 15149.0, 15225.847741522664, 15798.289076991448, 15807.130607816565, 15823.208839557976, 14236.430542778277, 14531.709365812625, 14572.854271457256, 14718.779218311734, 14744.631384215374, 12884.420201090974, 12967.416466259041, 13134.014948878777, 13165.1442656228, 13802.17186968775, 3878.2243551289853, 4007.479027726406, 4432.335149727534, 4495.123450927071, 4522.389477420539, 63894.0, 64029.35970640281, 64190.358096419375, 64256.67871660612, 65272.3472765271, 11907.940460297816, 11908.88091119095, 11989.460474278678, 11991.520339186334, 12169.69575760613, 21108.577828443653, 21131.577368452545, 21142.47143821386, 21293.0, 21330.89334553317, 8470.0, 8509.106543812934, 8516.446430981967, 8713.215810576952, 8728.476291422536, 4704.835330763407, 4755.667103302736, 4786.1863483207935, 4890.0, 4903.362562866804, 3764.604716504782, 3844.75009124406, 3884.902877428087, 3890.2608504384075, 3906.062544989239, 625.4996003197424, 633.4299130782333, 638.7157714816955, 639.4085470939362, 656.7701304543467, 642.3127253838442, 750.7860259825924, 759.525296689569, 771.1786946901644, 793.1988691421706, 9193.862092068624, 9744.0, 9769.804603907882, 9871.309008369346, 9999.0, 668.9598624082571, 676.3067855448205, 725.2783480436999, 730.7150211417552, 741.4253953186324, 4573.428321459817, 4707.5057119002695, 4822.565969062731, 4831.4685384607665, 4910.0, 83785.58107209425, 85387.5730621343, 85503.57248213718, 85526.57236713776, 88196.0, 77824.22175778283, 78949.0, 79053.20946790573, 79613.20386796058, 81213.0, 70233.0, 70865.2913470869, 71046.64476677583, 71064.64467677628, 74207.0, 9186.54067296646, 9456.2907781918, 9472.668456603986, 9527.428354298765, 9527.821277776655, 47733.0, 48201.96022570995, 48424.27363589619, 49180.508194917595, 49789.004219916125, 64112.67943660438, 64184.35815641784, 65547.34452655412, 65701.0, 65988.67005664941, 12346.880991883241, 12753.234805911676, 12767.489300427878, 12794.360281985677, 13141.802872957105, 13134.343282836011, 13146.80279795823, 13299.0, 13358.666033349244, 13494.93252533731, 12532.874671253536, 12641.747165056831, 12687.0, 13258.867411325764, 13279.40242689062, 12206.389680515762, 12304.81542776877, 12443.688907777378, 12903.548375806802, 13085.542006029744, 11612.477438515456, 11961.820572691591, 11978.880211198126, 12434.253944763343, 12552.874471255536, 10042.849357259793, 10079.24405669563, 10204.540795664065, 10241.641542545975, 10397.42814145199, 10874.0, 10954.671359859218, 11024.952629500185, 11154.721131971766, 11191.384473854016], "value": 7413.262668906972, "unit": "score"}], "name": "dromaeo_css", "value": 7432.465574326175, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 113.0, 114.0, 114.0, 113.0, 113.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 127.0, 159.0, 129.0, 127.0, 122.0, 123.0, 154.0, 125.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 118.0, 75.0, 76.0, 75.0, 76.0, 96.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 108.0, 82.0, 82.0, 82.0, 99.0, 82.0, 83.0, 113.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 126.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 147.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 50.0, 50.0, 49.0, 53.0, 50.0, 50.0, 49.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 74.0, 75.0, 75.0, 74.0, 75.0, 74.0, 80.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 129.0, 127.0, 127.0, 128.0, 128.0, 125.0, 164.0, 125.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 157.0, 158.0, 151.0, 157.0, 152.0, 158.0, 152.0, 159.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 65.0, 61.0, 61.0, 61.0, 60.0, 62.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1458.9, "alertThreshold": 2.0}]} 14:57:41 INFO - Return code: 0 14:57:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:57:41 ERROR - # TBPL SUCCESS # 14:57:41 INFO - Running post-action listener: _resource_record_post_action 14:57:41 INFO - [mozharness: 2016-11-15 22:57:41.253741Z] Finished run-tests step (success) 14:57:41 INFO - Running post-run listener: _resource_record_post_run 14:57:41 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 270336; Write bytes: 357089280; Read time: 52; Write time: 269104 14:57:41 INFO - TinderboxPrint: CPU usage
13.0% 14:57:41 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 52 14:57:41 INFO - TinderboxPrint: I/O write bytes / time
357,089,280 / 269,104 14:57:41 INFO - TinderboxPrint: CPU idle
8,273.4 (87.0%) 14:57:41 INFO - TinderboxPrint: CPU user
1,188.3 (12.5%) 14:57:41 INFO - TinderboxPrint: Swap in / out
0 / 0 14:57:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107200512; Read time: 0; Write time: 86456 14:57:41 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249331712; Read time: 36; Write time: 182640 14:57:41 INFO - Running post-run listener: _upload_blobber_files 14:57:41 INFO - Blob upload gear active. 14:57:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:57:41 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 14:57:41 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'] 14:57:41 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 14:57:42 INFO - (blobuploader) - INFO - Open directory for files ... 14:57:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:57:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:57:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:43 INFO - (blobuploader) - INFO - Done attempting. 14:57:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:57:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:47 INFO - (blobuploader) - INFO - Done attempting. 14:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:57:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:48 INFO - (blobuploader) - INFO - Done attempting. 14:57:48 INFO - (blobuploader) - INFO - Iteration through files over. 14:57:48 INFO - Return code: 0 14:57:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:57:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:57:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e580b3854511ae2a1d3d7b1efebae9d13cb14e9de9b7ebcc7d22e36347b1892557b41b576768a298c7b9ef9634bdcbc0b28a0805f2c932192310bb38ba22b468", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c72ec04de779f99816b7f14c3eadd67d16cd07080d5cfd73e2b21398ee4b49e848dd08996eab56aa8cedc33a9e3cd1227c155b6af12d672a7949b66cf2b11df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e2edaac7f312dc90bd1b8965b0d9b632ac1f6a826dc3aba10496be1201dd6de7b7058a66cccf74ce45bf38c8cfaab85a9f05cbcb4514ec603a451871cc602b7"} 14:57:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:57:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:57:48 INFO - Contents: 14:57:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e580b3854511ae2a1d3d7b1efebae9d13cb14e9de9b7ebcc7d22e36347b1892557b41b576768a298c7b9ef9634bdcbc0b28a0805f2c932192310bb38ba22b468", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c72ec04de779f99816b7f14c3eadd67d16cd07080d5cfd73e2b21398ee4b49e848dd08996eab56aa8cedc33a9e3cd1227c155b6af12d672a7949b66cf2b11df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e2edaac7f312dc90bd1b8965b0d9b632ac1f6a826dc3aba10496be1201dd6de7b7058a66cccf74ce45bf38c8cfaab85a9f05cbcb4514ec603a451871cc602b7"} 14:57:48 INFO - Running post-run listener: copy_logs_to_upload_dir 14:57:48 INFO - Copying logs to upload dir... 14:57:48 INFO - mkdir: /builds/slave/test/build/upload/logs 14:57:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.820057 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-15 14:57:47.968906) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 14:57:47.972092) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032 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/e580b3854511ae2a1d3d7b1efebae9d13cb14e9de9b7ebcc7d22e36347b1892557b41b576768a298c7b9ef9634bdcbc0b28a0805f2c932192310bb38ba22b468", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c72ec04de779f99816b7f14c3eadd67d16cd07080d5cfd73e2b21398ee4b49e848dd08996eab56aa8cedc33a9e3cd1227c155b6af12d672a7949b66cf2b11df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e2edaac7f312dc90bd1b8965b0d9b632ac1f6a826dc3aba10496be1201dd6de7b7058a66cccf74ce45bf38c8cfaab85a9f05cbcb4514ec603a451871cc602b7"} build_url:https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011828 build_url: 'https://queue.taskcluster.net/v1/task/XfQzjOYaSSq9E1wVWvc5Zw/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/e580b3854511ae2a1d3d7b1efebae9d13cb14e9de9b7ebcc7d22e36347b1892557b41b576768a298c7b9ef9634bdcbc0b28a0805f2c932192310bb38ba22b468", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c72ec04de779f99816b7f14c3eadd67d16cd07080d5cfd73e2b21398ee4b49e848dd08996eab56aa8cedc33a9e3cd1227c155b6af12d672a7949b66cf2b11df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e2edaac7f312dc90bd1b8965b0d9b632ac1f6a826dc3aba10496be1201dd6de7b7058a66cccf74ce45bf38c8cfaab85a9f05cbcb4514ec603a451871cc602b7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 14:57:47.997597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:57:47.997919) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1479248548.297777-1708461032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 14:57:48.082436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 14:57:48.082771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 14:57:48.083071) ========= ========= Total master_lag: 0.17 =========