builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1479750677.25 results: success (0) buildid: 20161121065108 builduid: 3a3c776276db4b78930048a5ec81a327 revision: c58b40f5e8b398c225df819b28314c57181273dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:17.247501) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:17.247971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:17.248254) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:17.262679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:17.263035) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-21 09:51:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-11-21 09:51:21 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:17.391784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:17.392103) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017503 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:17.441910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 09:51:17.442264) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c58b40f5e8b398c225df819b28314c57181273dd --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 c58b40f5e8b398c225df819b28314c57181273dd --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=97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 09:51:21,391 truncating revision to first 12 chars 2016-11-21 09:51:21,391 Setting DEBUG logging. 2016-11-21 09:51:21,391 attempt 1/10 2016-11-21 09:51:21,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c58b40f5e8b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 09:51:22,791 unpacking tar archive at: mozilla-aurora-c58b40f5e8b3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.730052 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 09:51:19.185626) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:19.185970) ========= script_repo_revision: c58b40f5e8b398c225df819b28314c57181273dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:19.186408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:19.186669) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 09:51:19.195420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-21 09:51:19.195820) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:51:23 INFO - MultiFileLogger online at 20161121 09:51:23 in /builds/slave/test 09:51:23 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 09:51:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:51:23 INFO - {'append_to_log': False, 09:51:23 INFO - 'base_work_dir': '/builds/slave/test', 09:51:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:51:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:51:23 INFO - 'branch': 'Mozilla-Aurora', 09:51:23 INFO - 'buildbot_json_path': 'buildprops.json', 09:51:23 INFO - 'config_files': ('talos/linux_config.py',), 09:51:23 INFO - 'default_actions': ('clobber', 09:51:23 INFO - 'read-buildbot-config', 09:51:23 INFO - 'download-and-extract', 09:51:23 INFO - 'populate-webroot', 09:51:23 INFO - 'create-virtualenv', 09:51:23 INFO - 'install', 09:51:23 INFO - 'run-tests'), 09:51:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:51:23 INFO - 'download_minidump_stackwalk': True, 09:51:23 INFO - 'download_symbols': 'ondemand', 09:51:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:51:23 INFO - 'tooltool.py': '/tools/tooltool.py', 09:51:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:51:23 INFO - '/tools/misc-python/virtualenv.py')}, 09:51:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:51:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:51:23 INFO - 'installer_path': 'installer.exe', 09:51:23 INFO - 'log_level': 'info', 09:51:23 INFO - 'log_name': 'talos', 09:51:23 INFO - 'log_to_console': True, 09:51:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:51:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:51:23 INFO - 'opt_config_files': (), 09:51:23 INFO - 'pip_index': False, 09:51:23 INFO - 'sps_profile': False, 09:51:23 INFO - 'sps_profile_interval': 0, 09:51:23 INFO - 'suite': 'dromaeojs', 09:51:23 INFO - 'system_bits': '32', 09:51:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:51:23 INFO - 'title': 'talos-linux64-ix-068', 09:51:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:51:23 INFO - 'use_talos_json': True, 09:51:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:51:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:51:23 INFO - 'work_dir': 'build'} 09:51:23 INFO - [mozharness: 2016-11-21 17:51:23.246076Z] Running clobber step. 09:51:23 INFO - Running pre-action listener: _resource_record_pre_action 09:51:23 INFO - Running main action method: clobber 09:51:23 INFO - rmtree: /builds/slave/test/build 09:51:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:51:23 INFO - Running post-action listener: _resource_record_post_action 09:51:23 INFO - [mozharness: 2016-11-21 17:51:23.747164Z] Finished clobber step (success) 09:51:23 INFO - [mozharness: 2016-11-21 17:51:23.747277Z] Running read-buildbot-config step. 09:51:23 INFO - Running pre-action listener: _resource_record_pre_action 09:51:23 INFO - Running main action method: read_buildbot_config 09:51:23 INFO - Using buildbot properties: 09:51:23 INFO - { 09:51:23 INFO - "project": "", 09:51:23 INFO - "product": "firefox", 09:51:23 INFO - "script_repo_revision": "production", 09:51:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:51:23 INFO - "repository": "", 09:51:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:51:23 INFO - "buildid": "20161121065108", 09:51:23 INFO - "pgo_build": "True", 09:51:23 INFO - "basedir": "/builds/slave/test", 09:51:23 INFO - "buildnumber": 610, 09:51:23 INFO - "slavename": "talos-linux64-ix-068", 09:51:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:51:23 INFO - "platform": "ubuntu64_hw", 09:51:23 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:51:23 INFO - "branch": "mozilla-aurora", 09:51:23 INFO - "repo_path": "releases/mozilla-aurora", 09:51:23 INFO - "revision": "c58b40f5e8b398c225df819b28314c57181273dd", 09:51:23 INFO - "stage_platform": "linux64-pgo", 09:51:23 INFO - "builduid": "3a3c776276db4b78930048a5ec81a327", 09:51:23 INFO - "slavebuilddir": "test" 09:51:23 INFO - } 09:51:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:51:23 INFO - Running post-action listener: _resource_record_post_action 09:51:23 INFO - [mozharness: 2016-11-21 17:51:23.749701Z] Finished read-buildbot-config step (success) 09:51:23 INFO - [mozharness: 2016-11-21 17:51:23.749808Z] Running download-and-extract step. 09:51:23 INFO - Running pre-action listener: _resource_record_pre_action 09:51:23 INFO - Running main action method: download_and_extract 09:51:23 INFO - mkdir: /builds/slave/test/build/tests 09:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:23 INFO - trying https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:51:23 INFO - Downloading https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:51:24 INFO - Downloaded 1361 bytes. 09:51:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:51:24 INFO - Using the following test package requirements: 09:51:24 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:51:24 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:51:24 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:51:24 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'jsshell-linux-x86_64.zip'], 09:51:24 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:51:24 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:51:24 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:51:24 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:51:24 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:51:24 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:51:24 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:51:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:51:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:51:24 INFO - Fetch https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:51:24 INFO - Http code: 200 09:51:24 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 09:51:24 INFO - x-amz-cf-id: xfS-DaZVJhSLHrNkjGxVHyvPmqYKxq1BE70xdYgAgZDNsXPmInI2Gw== 09:51:24 INFO - x-amz-version-id: onkrZY7cDwrz7UTWp_k9VcBpu6Sc5w3v 09:51:25 INFO - Expected file size: 21947271 09:51:25 INFO - Obtained file size: 21947271 09:51:29 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:51:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:51:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:51:29 INFO - Fetch https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:51:29 INFO - Http code: 200 09:51:29 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 09:51:29 INFO - x-amz-cf-id: S4PcHKTHGld-S3iUwwpRtEOcTuycN4Oo_ndFsFzGy4KZd2DO8N2H8w== 09:51:29 INFO - x-amz-version-id: onkrZY7cDwrz7UTWp_k9VcBpu6Sc5w3v 09:51:29 INFO - Expected file size: 21947271 09:51:29 INFO - Obtained file size: 21947271 09:51:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:51:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:51:34 INFO - Fetch https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:51:34 INFO - Http code: 200 09:51:34 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 09:51:34 INFO - x-amz-cf-id: 2Yyjp2Une12hhjk6TTrxUXc9zez64uQZvWyaeN2IWLIguxGNMjkCCA== 09:51:34 INFO - x-amz-version-id: Uq8rITM_Vz0XhlYxaw7eAiz.hWviY6Uu 09:51:35 INFO - Expected file size: 14409038 09:51:35 INFO - Obtained file size: 14409038 09:51: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')]} 09:51:35 INFO - trying https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:51:35 INFO - Downloading https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:51:36 INFO - Downloaded 63964956 bytes. 09:51:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:51:36 INFO - mkdir: /builds/slave/test/properties 09:51:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:51:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:51:36 INFO - Contents: 09:51:36 INFO - build_url:https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:51:37 INFO - Running post-action listener: _resource_record_post_action 09:51:37 INFO - Running post-action listener: set_extra_try_arguments 09:51:37 INFO - [mozharness: 2016-11-21 17:51:37.222984Z] Finished download-and-extract step (success) 09:51:37 INFO - [mozharness: 2016-11-21 17:51:37.223209Z] Running populate-webroot step. 09:51:37 INFO - Running pre-action listener: _resource_record_pre_action 09:51:37 INFO - Running main action method: populate_webroot 09:51:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:37 INFO - '--tppagecycles', 09:51:37 INFO - '7'], 09:51:37 INFO - 'tests': ['tsvgm']}}, 09:51:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:51:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:51:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:37 INFO - 'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:37 INFO - 'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['damp', 'tps']}, 09:51:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:37 INFO - 'tests': ['damp', 'tps']}, 09:51:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['dromaeo_dom']}, 09:51:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['basic_compositor_video']}, 09:51:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:51:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['a11yr', 09:51:37 INFO - 'ts_paint', 09:51:37 INFO - 'tpaint', 09:51:37 INFO - 'sessionrestore', 09:51:37 INFO - 'sessionrestore_no_auto_restore', 09:51:37 INFO - 'tabpaint']}, 09:51:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:51:37 INFO - 'ts_paint', 09:51:37 INFO - 'tpaint', 09:51:37 INFO - 'sessionrestore', 09:51:37 INFO - 'sessionrestore_no_auto_restore', 09:51:37 INFO - 'tabpaint']}, 09:51:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:51:37 INFO - 'ts_paint', 09:51:37 INFO - 'tpaint', 09:51:37 INFO - 'sessionrestore', 09:51:37 INFO - 'sessionrestore_no_auto_restore', 09:51:37 INFO - 'tabpaint']}, 09:51:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:51:37 INFO - 'ts_paint', 09:51:37 INFO - 'tpaint', 09:51:37 INFO - 'sessionrestore', 09:51:37 INFO - 'sessionrestore_no_auto_restore', 09:51:37 INFO - 'tabpaint']}, 09:51:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['a11yr', 09:51:37 INFO - 'ts_paint', 09:51:37 INFO - 'tpaint', 09:51:37 INFO - 'sessionrestore', 09:51:37 INFO - 'sessionrestore_no_auto_restore', 09:51:37 INFO - 'tabpaint']}, 09:51:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['a11yr', 09:51:37 INFO - 'ts_paint', 09:51:37 INFO - 'tpaint', 09:51:37 INFO - 'sessionrestore', 09:51:37 INFO - 'sessionrestore_no_auto_restore', 09:51:37 INFO - 'tabpaint']}, 09:51:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['tsvgx', 09:51:37 INFO - 'tsvgr_opacity', 09:51:37 INFO - 'tart', 09:51:37 INFO - 'tscrollx', 09:51:37 INFO - 'cart']}, 09:51:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:51:37 INFO - 'tsvgr_opacity', 09:51:37 INFO - 'tart', 09:51:37 INFO - 'tscrollx', 09:51:37 INFO - 'cart']}, 09:51:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:37 INFO - 'talos_options': ['--disable-e10s'], 09:51:37 INFO - 'tests': ['tp5o']}, 09:51:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:37 INFO - 'tests': ['tp5o']}, 09:51:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:37 INFO - 'talos_options': ['--disable-e10s', 09:51:37 INFO - '--xperf_path', 09:51:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:37 INFO - 'tests': ['tp5n']}, 09:51:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:37 INFO - 'talos_options': ['--xperf_path', 09:51:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:37 INFO - 'tests': ['tp5n']}}, 09:51:37 INFO - 'talos.zip': {'path': '', 09:51:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:37 INFO - Running post-action listener: _resource_record_post_action 09:51:37 INFO - [mozharness: 2016-11-21 17:51:37.245626Z] Finished populate-webroot step (success) 09:51:37 INFO - [mozharness: 2016-11-21 17:51:37.245714Z] Running create-virtualenv step. 09:51:37 INFO - Running pre-action listener: _resource_record_pre_action 09:51:37 INFO - Running main action method: create_virtualenv 09:51:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:51:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:51:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:51:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:37 INFO - Using real prefix '/usr' 09:51:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:51:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:39 INFO - Installing pip.................done. 09:51:39 INFO - Return code: 0 09:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:51:40 INFO - Reading from file tmpfile_stdout 09:51:40 INFO - Output received: 09:51:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:51:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:51:40 INFO - Using env: {'DISPLAY': ':0', 09:51:40 INFO - 'HOME': '/home/cltbld', 09:51:40 INFO - 'LANG': 'en_US.UTF-8', 09:51:40 INFO - 'LANGUAGE': 'en_US:en', 09:51:40 INFO - 'LOGNAME': 'cltbld', 09:51:40 INFO - 'MAIL': '/var/mail/cltbld', 09:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:40 INFO - 'MOZ_NO_REMOTE': '1', 09:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:40 INFO - 'NO_EM_RESTART': '1', 09:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:40 INFO - 'PWD': '/builds/slave/test', 09:51:40 INFO - 'SHELL': '/bin/bash', 09:51:40 INFO - 'SHLVL': '1', 09:51:40 INFO - 'TERM': 'linux', 09:51:40 INFO - 'TMOUT': '86400', 09:51:40 INFO - 'USER': 'cltbld', 09:51:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:40 INFO - '_': '/tools/buildbot/bin/python'} 09:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:51:40 INFO - Cleaning up... 09:51:40 INFO - Return code: 0 09:51:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:40 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:51:40 INFO - Using env: {'DISPLAY': ':0', 09:51:40 INFO - 'HOME': '/home/cltbld', 09:51:40 INFO - 'LANG': 'en_US.UTF-8', 09:51:40 INFO - 'LANGUAGE': 'en_US:en', 09:51:40 INFO - 'LOGNAME': 'cltbld', 09:51:40 INFO - 'MAIL': '/var/mail/cltbld', 09:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:40 INFO - 'MOZ_NO_REMOTE': '1', 09:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:40 INFO - 'NO_EM_RESTART': '1', 09:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:40 INFO - 'PWD': '/builds/slave/test', 09:51:40 INFO - 'SHELL': '/bin/bash', 09:51:40 INFO - 'SHLVL': '1', 09:51:40 INFO - 'TERM': 'linux', 09:51:40 INFO - 'TMOUT': '86400', 09:51:40 INFO - 'USER': 'cltbld', 09:51:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:40 INFO - '_': '/tools/buildbot/bin/python'} 09:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:40 INFO - Downloading/unpacking psutil>=3.1.1 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:42 INFO - Installing collected packages: psutil 09:51:42 INFO - Running setup.py install for psutil 09:51:42 INFO - building 'psutil._psutil_linux' extension 09:51:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:51:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:51:42 INFO - building 'psutil._psutil_posix' extension 09:51:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:51:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:51:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:43 INFO - Successfully installed psutil 09:51:43 INFO - Cleaning up... 09:51:43 INFO - Return code: 0 09:51:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:43 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:51:43 INFO - Using env: {'DISPLAY': ':0', 09:51:43 INFO - 'HOME': '/home/cltbld', 09:51:43 INFO - 'LANG': 'en_US.UTF-8', 09:51:43 INFO - 'LANGUAGE': 'en_US:en', 09:51:43 INFO - 'LOGNAME': 'cltbld', 09:51:43 INFO - 'MAIL': '/var/mail/cltbld', 09:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:43 INFO - 'MOZ_NO_REMOTE': '1', 09:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:43 INFO - 'NO_EM_RESTART': '1', 09:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:43 INFO - 'PWD': '/builds/slave/test', 09:51:43 INFO - 'SHELL': '/bin/bash', 09:51:43 INFO - 'SHLVL': '1', 09:51:43 INFO - 'TERM': 'linux', 09:51:43 INFO - 'TMOUT': '86400', 09:51:43 INFO - 'USER': 'cltbld', 09:51:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:43 INFO - '_': '/tools/buildbot/bin/python'} 09:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:51:45 INFO - Installing collected packages: mozsystemmonitor 09:51:45 INFO - Running setup.py install for mozsystemmonitor 09:51:45 INFO - Successfully installed mozsystemmonitor 09:51:45 INFO - Cleaning up... 09:51:45 INFO - Return code: 0 09:51:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:45 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:51:45 INFO - Using env: {'DISPLAY': ':0', 09:51:45 INFO - 'HOME': '/home/cltbld', 09:51:45 INFO - 'LANG': 'en_US.UTF-8', 09:51:45 INFO - 'LANGUAGE': 'en_US:en', 09:51:45 INFO - 'LOGNAME': 'cltbld', 09:51:45 INFO - 'MAIL': '/var/mail/cltbld', 09:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:45 INFO - 'MOZ_NO_REMOTE': '1', 09:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:45 INFO - 'NO_EM_RESTART': '1', 09:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:45 INFO - 'PWD': '/builds/slave/test', 09:51:45 INFO - 'SHELL': '/bin/bash', 09:51:45 INFO - 'SHLVL': '1', 09:51:45 INFO - 'TERM': 'linux', 09:51:45 INFO - 'TMOUT': '86400', 09:51:45 INFO - 'USER': 'cltbld', 09:51:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:45 INFO - '_': '/tools/buildbot/bin/python'} 09:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:45 INFO - Downloading/unpacking jsonschema==2.5.1 09:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:47 INFO - warning: no files found matching '*.txt' 09:51:47 INFO - no previously-included directories found matching 'build' 09:51:47 INFO - no previously-included directories found matching 'dist' 09:51:47 INFO - no previously-included directories found matching '.git*' 09:51:47 INFO - Installing collected packages: jsonschema, functools32 09:51:47 INFO - Running setup.py install for functools32 09:51:48 INFO - warning: no files found matching '*.txt' 09:51:48 INFO - no previously-included directories found matching 'build' 09:51:48 INFO - no previously-included directories found matching 'dist' 09:51:48 INFO - no previously-included directories found matching '.git*' 09:51:48 INFO - Successfully installed jsonschema functools32 09:51:48 INFO - Cleaning up... 09:51:48 INFO - Return code: 0 09:51:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:48 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:51:48 INFO - Using env: {'DISPLAY': ':0', 09:51:48 INFO - 'HOME': '/home/cltbld', 09:51:48 INFO - 'LANG': 'en_US.UTF-8', 09:51:48 INFO - 'LANGUAGE': 'en_US:en', 09:51:48 INFO - 'LOGNAME': 'cltbld', 09:51:48 INFO - 'MAIL': '/var/mail/cltbld', 09:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:48 INFO - 'MOZ_NO_REMOTE': '1', 09:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:48 INFO - 'NO_EM_RESTART': '1', 09:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:48 INFO - 'PWD': '/builds/slave/test', 09:51:48 INFO - 'SHELL': '/bin/bash', 09:51:48 INFO - 'SHLVL': '1', 09:51:48 INFO - 'TERM': 'linux', 09:51:48 INFO - 'TMOUT': '86400', 09:51:48 INFO - 'USER': 'cltbld', 09:51:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:48 INFO - '_': '/tools/buildbot/bin/python'} 09:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:51:48 INFO - Cleaning up... 09:51:48 INFO - Return code: 0 09:51:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:48 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:51:48 INFO - Using env: {'DISPLAY': ':0', 09:51:48 INFO - 'HOME': '/home/cltbld', 09:51:48 INFO - 'LANG': 'en_US.UTF-8', 09:51:48 INFO - 'LANGUAGE': 'en_US:en', 09:51:48 INFO - 'LOGNAME': 'cltbld', 09:51:48 INFO - 'MAIL': '/var/mail/cltbld', 09:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:48 INFO - 'MOZ_NO_REMOTE': '1', 09:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:48 INFO - 'NO_EM_RESTART': '1', 09:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:48 INFO - 'PWD': '/builds/slave/test', 09:51:48 INFO - 'SHELL': '/bin/bash', 09:51:48 INFO - 'SHLVL': '1', 09:51:48 INFO - 'TERM': 'linux', 09:51:48 INFO - 'TMOUT': '86400', 09:51:48 INFO - 'USER': 'cltbld', 09:51:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:48 INFO - '_': '/tools/buildbot/bin/python'} 09:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:51 INFO - Downloading docopt-0.6.1.tar.gz 09:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:51 INFO - Running setup.py install for blobuploader 09:51:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:51 INFO - Running setup.py install for requests 09:51:51 INFO - Running setup.py install for docopt 09:51:51 INFO - Successfully installed blobuploader requests docopt 09:51:51 INFO - Cleaning up... 09:51:51 INFO - Return code: 0 09:51:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:51 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:51 INFO - Using env: {'DISPLAY': ':0', 09:51:51 INFO - 'HOME': '/home/cltbld', 09:51:51 INFO - 'LANG': 'en_US.UTF-8', 09:51:51 INFO - 'LANGUAGE': 'en_US:en', 09:51:51 INFO - 'LOGNAME': 'cltbld', 09:51:51 INFO - 'MAIL': '/var/mail/cltbld', 09:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:51 INFO - 'MOZ_NO_REMOTE': '1', 09:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:51 INFO - 'NO_EM_RESTART': '1', 09:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:51 INFO - 'PWD': '/builds/slave/test', 09:51:51 INFO - 'SHELL': '/bin/bash', 09:51:51 INFO - 'SHLVL': '1', 09:51:51 INFO - 'TERM': 'linux', 09:51:51 INFO - 'TMOUT': '86400', 09:51:51 INFO - 'USER': 'cltbld', 09:51:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:51 INFO - '_': '/tools/buildbot/bin/python'} 09:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:52 INFO - Running setup.py (path:/tmp/pip-DiJEL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:52 INFO - Running setup.py (path:/tmp/pip-xoAv6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:52 INFO - Running setup.py (path:/tmp/pip-LUZi_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:52 INFO - Running setup.py (path:/tmp/pip-85VW_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:52 INFO - Running setup.py (path:/tmp/pip-WQYxez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:52 INFO - Running setup.py (path:/tmp/pip-bPQU8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:52 INFO - Running setup.py (path:/tmp/pip-cQgq7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:52 INFO - Running setup.py (path:/tmp/pip-ocJ2ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:52 INFO - Running setup.py (path:/tmp/pip-g_boZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:52 INFO - Running setup.py (path:/tmp/pip-DKSA1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:52 INFO - Running setup.py (path:/tmp/pip-5LNXOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:52 INFO - Running setup.py (path:/tmp/pip-ouRZ_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:52 INFO - Running setup.py (path:/tmp/pip-Grv70U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:53 INFO - Running setup.py (path:/tmp/pip-hp3ie5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:53 INFO - Running setup.py (path:/tmp/pip-7Cr7OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:53 INFO - Running setup.py (path:/tmp/pip-I8JxlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:53 INFO - Running setup.py (path:/tmp/pip-e1cueB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:53 INFO - Running setup.py install for manifestparser 09:51:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:53 INFO - Running setup.py install for mozcrash 09:51:53 INFO - Running setup.py install for mozdebug 09:51:53 INFO - Running setup.py install for mozdevice 09:51:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:53 INFO - Running setup.py install for mozfile 09:51:53 INFO - Running setup.py install for mozhttpd 09:51:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:53 INFO - Running setup.py install for mozinfo 09:51:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Running setup.py install for mozInstall 09:51:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Running setup.py install for mozleak 09:51:54 INFO - Running setup.py install for mozlog 09:51:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Running setup.py install for moznetwork 09:51:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Running setup.py install for mozprocess 09:51:54 INFO - Running setup.py install for mozprofile 09:51:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Running setup.py install for mozrunner 09:51:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:54 INFO - Running setup.py install for mozscreenshot 09:51:54 INFO - Running setup.py install for moztest 09:51:55 INFO - Running setup.py install for mozversion 09:51:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:55 INFO - Cleaning up... 09:51:55 INFO - Return code: 0 09:51:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:55 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:55 INFO - Using env: {'DISPLAY': ':0', 09:51:55 INFO - 'HOME': '/home/cltbld', 09:51:55 INFO - 'LANG': 'en_US.UTF-8', 09:51:55 INFO - 'LANGUAGE': 'en_US:en', 09:51:55 INFO - 'LOGNAME': 'cltbld', 09:51:55 INFO - 'MAIL': '/var/mail/cltbld', 09:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:55 INFO - 'MOZ_NO_REMOTE': '1', 09:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:55 INFO - 'NO_EM_RESTART': '1', 09:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:55 INFO - 'PWD': '/builds/slave/test', 09:51:55 INFO - 'SHELL': '/bin/bash', 09:51:55 INFO - 'SHLVL': '1', 09:51:55 INFO - 'TERM': 'linux', 09:51:55 INFO - 'TMOUT': '86400', 09:51:55 INFO - 'USER': 'cltbld', 09:51:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:55 INFO - '_': '/tools/buildbot/bin/python'} 09:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:55 INFO - Running setup.py (path:/tmp/pip-5rdaMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:55 INFO - Running setup.py (path:/tmp/pip-lrF8_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:55 INFO - Running setup.py (path:/tmp/pip-a6ihbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:55 INFO - Running setup.py (path:/tmp/pip-RjldPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:55 INFO - Running setup.py (path:/tmp/pip-H27B_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:55 INFO - Running setup.py (path:/tmp/pip-KtU1yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:55 INFO - Running setup.py (path:/tmp/pip-GH_2AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:55 INFO - Running setup.py (path:/tmp/pip-LuI1TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:51:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:55 INFO - Running setup.py (path:/tmp/pip-RRMmBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:56 INFO - Running setup.py (path:/tmp/pip-Is_Fc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:56 INFO - Running setup.py (path:/tmp/pip-RxRycg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:56 INFO - Running setup.py (path:/tmp/pip-dJsEnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:56 INFO - Running setup.py (path:/tmp/pip-RLQ5ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:56 INFO - Running setup.py (path:/tmp/pip-GnSGcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:56 INFO - Running setup.py (path:/tmp/pip-zWK0fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:56 INFO - Running setup.py (path:/tmp/pip-NE_EAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:56 INFO - Running setup.py (path:/tmp/pip-ta94rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:58 INFO - Downloading blessings-1.6.tar.gz 09:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:58 INFO - Installing collected packages: blessings 09:51:58 INFO - Running setup.py install for blessings 09:51:58 INFO - Successfully installed blessings 09:51:58 INFO - Cleaning up... 09:51:58 INFO - Return code: 0 09:51:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:59 INFO - Reading from file tmpfile_stdout 09:51:59 INFO - Current package versions: 09:51:59 INFO - argparse == 1.2.1 09:51:59 INFO - blessings == 1.6 09:51:59 INFO - blobuploader == 1.2.4 09:51:59 INFO - docopt == 0.6.1 09:51:59 INFO - functools32 == 3.2.3-2 09:51:59 INFO - jsonschema == 2.5.1 09:51:59 INFO - manifestparser == 1.1 09:51:59 INFO - mozInstall == 1.12 09:51:59 INFO - mozcrash == 1.0 09:51:59 INFO - mozdebug == 0.1 09:51:59 INFO - mozdevice == 0.48 09:51:59 INFO - mozfile == 1.2 09:51:59 INFO - mozhttpd == 0.7 09:51:59 INFO - mozinfo == 0.9 09:51:59 INFO - mozleak == 0.1 09:51:59 INFO - mozlog == 3.4 09:51:59 INFO - moznetwork == 0.27 09:51:59 INFO - mozprocess == 0.23 09:51:59 INFO - mozprofile == 0.28 09:51:59 INFO - mozrunner == 6.13 09:51:59 INFO - mozscreenshot == 0.1 09:51:59 INFO - mozsystemmonitor == 0.3 09:51:59 INFO - moztest == 0.7 09:51:59 INFO - mozversion == 1.4 09:51:59 INFO - psutil == 3.1.1 09:51:59 INFO - requests == 1.2.3 09:51:59 INFO - wsgiref == 0.1.2 09:51:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:59 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:59 INFO - Using env: {'DISPLAY': ':0', 09:51:59 INFO - 'HOME': '/home/cltbld', 09:51:59 INFO - 'LANG': 'en_US.UTF-8', 09:51:59 INFO - 'LANGUAGE': 'en_US:en', 09:51:59 INFO - 'LOGNAME': 'cltbld', 09:51:59 INFO - 'MAIL': '/var/mail/cltbld', 09:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:59 INFO - 'MOZ_NO_REMOTE': '1', 09:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:59 INFO - 'NO_EM_RESTART': '1', 09:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:59 INFO - 'PWD': '/builds/slave/test', 09:51:59 INFO - 'SHELL': '/bin/bash', 09:51:59 INFO - 'SHLVL': '1', 09:51:59 INFO - 'TERM': 'linux', 09:51:59 INFO - 'TMOUT': '86400', 09:51:59 INFO - 'USER': 'cltbld', 09:51:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:59 INFO - '_': '/tools/buildbot/bin/python'} 09:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:51:59 INFO - Cleaning up... 09:51:59 INFO - Return code: 0 09:51:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:59 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 0x7f929a4f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b06ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:51:59 INFO - Using env: {'DISPLAY': ':0', 09:51:59 INFO - 'HOME': '/home/cltbld', 09:51:59 INFO - 'LANG': 'en_US.UTF-8', 09:51:59 INFO - 'LANGUAGE': 'en_US:en', 09:51:59 INFO - 'LOGNAME': 'cltbld', 09:51:59 INFO - 'MAIL': '/var/mail/cltbld', 09:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:59 INFO - 'MOZ_NO_REMOTE': '1', 09:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:59 INFO - 'NO_EM_RESTART': '1', 09:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:59 INFO - 'PWD': '/builds/slave/test', 09:51:59 INFO - 'SHELL': '/bin/bash', 09:51:59 INFO - 'SHLVL': '1', 09:51:59 INFO - 'TERM': 'linux', 09:51:59 INFO - 'TMOUT': '86400', 09:51:59 INFO - 'USER': 'cltbld', 09:51:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:59 INFO - '_': '/tools/buildbot/bin/python'} 09:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:59 INFO - Cleaning up... 09:51:59 INFO - Return code: 0 09:51:59 INFO - Running post-action listener: _resource_record_post_action 09:51:59 INFO - Running post-action listener: _start_resource_monitoring 09:51:59 INFO - Starting resource monitoring. 09:51:59 INFO - [mozharness: 2016-11-21 17:51:59.535294Z] Finished create-virtualenv step (success) 09:51:59 INFO - [mozharness: 2016-11-21 17:51:59.535869Z] Running install step. 09:51:59 INFO - Running pre-action listener: _resource_record_pre_action 09:51:59 INFO - Running main action method: install 09:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:59 INFO - Reading from file tmpfile_stdout 09:51:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:59 INFO - Reading from file tmpfile_stdout 09:51:59 INFO - Output received: 09:51:59 INFO - Usage: mozinstall [options] installer 09:51:59 INFO - Options: 09:51:59 INFO - -h, --help show this help message and exit 09:51:59 INFO - -d DEST, --destination=DEST 09:51:59 INFO - Directory to install application into. [default: 09:51:59 INFO - "/builds/slave/test"] 09:51:59 INFO - --app=APP Application being installed. [default: firefox] 09:51:59 INFO - mkdir: /builds/slave/test/build/application 09:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:52:15 INFO - Reading from file tmpfile_stdout 09:52:15 INFO - Output received: 09:52:15 INFO - /builds/slave/test/build/application/firefox/firefox 09:52:15 INFO - Running post-action listener: _resource_record_post_action 09:52:15 INFO - [mozharness: 2016-11-21 17:52:15.762187Z] Finished install step (success) 09:52:15 INFO - [mozharness: 2016-11-21 17:52:15.762427Z] Running run-tests step. 09:52:15 INFO - Running pre-action listener: _resource_record_pre_action 09:52:15 INFO - Running main action method: run_tests 09:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:15 INFO - Python 2.7.3 09:52:15 INFO - Return code: 0 09:52:15 INFO - grabbing minidump binary from tooltool 09:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:15 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 0x2b03f60>, '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 0x2b04d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b051d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:52:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:52:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:52:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:15 INFO - Return code: 0 09:52:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:52:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:52:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:15 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/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 09:52:15 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/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 09:52:15 INFO - Using env: {'DISPLAY': ':0', 09:52:15 INFO - 'HOME': '/home/cltbld', 09:52:15 INFO - 'LANG': 'en_US.UTF-8', 09:52:15 INFO - 'LANGUAGE': 'en_US:en', 09:52:15 INFO - 'LOGNAME': 'cltbld', 09:52:15 INFO - 'MAIL': '/var/mail/cltbld', 09:52:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:15 INFO - 'MOZ_NO_REMOTE': '1', 09:52:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:15 INFO - 'NO_EM_RESTART': '1', 09:52:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:15 INFO - 'PWD': '/builds/slave/test', 09:52:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:15 INFO - 'SHELL': '/bin/bash', 09:52:15 INFO - 'SHLVL': '1', 09:52:15 INFO - 'TERM': 'linux', 09:52:15 INFO - 'TMOUT': '86400', 09:52:15 INFO - 'USER': 'cltbld', 09:52:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999', 09:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:15 INFO - '_': '/tools/buildbot/bin/python'} 09:52:15 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/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 09:52:16 INFO - mozversion application_buildid: 20161121065108 09:52:16 INFO - mozversion application_changeset: c58b40f5e8b398c225df819b28314c57181273dd 09:52:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:52:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:16 INFO - mozversion application_name: Firefox 09:52:16 INFO - mozversion application_remotingname: firefox-dev 09:52:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:52:16 INFO - mozversion application_vendor: Mozilla 09:52:16 INFO - mozversion application_version: 52.0a2 09:52:16 INFO - mozversion platform_buildid: 20161121065108 09:52:16 INFO - mozversion platform_changeset: c58b40f5e8b398c225df819b28314c57181273dd 09:52:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:52:16 INFO - mozversion platform_version: 52.0a2 09:52:16 INFO - using testdate: 1479750736 09:52:16 INFO - actual date: 1479750736 09:52:16 INFO - starting webserver on 'localhost:51261' 09:52:16 INFO - SUITE-START | Running 2 tests 09:52:16 INFO - TEST-START | dromaeo_css 09:52:16 INFO - operating with platform_type : linux_ 09:52:16 INFO - Initialising browser for dromaeo_css test... 09:52:16 INFO - TEST-INFO | started process 24025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXp56_/profile http://localhost:51261/getInfo.html) 09:52:19 ERROR - PROCESS | 24025 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 09:52:20 INFO - PROCESS | 24025 | __metrics Screen width/height:1600/1200 09:52:20 INFO - PROCESS | 24025 | colorDepth:24 09:52:20 INFO - PROCESS | 24025 | Browser inner width/height: 1024/697 09:52:20 INFO - PROCESS | 24025 | __metrics 09:52:20 INFO - PROCESS | 24025 | 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" 09:52:20 INFO - PROCESS | 24025 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:21 INFO - PROCESS | 24025 | console.error: PushService: 09:52:21 INFO - PROCESS | 24025 | stateChangeProcessEnqueue: Error transitioning state 09:52:21 INFO - PROCESS | 24025 | UnknownError 09:52:21 INFO - TEST-INFO | 24025: exit 0 09:52:21 INFO - Browser initialized. 09:52:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:21 INFO - TEST-INFO | started process 24116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXp56_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:33 INFO - PROCESS | 24116 | RSS: Main: 148144128 09:52:33 INFO - PROCESS | 24116 | 09:53:24 INFO - PROCESS | 24116 | 1479750804477 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:55:34 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:51261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51261/tests/dromaeo/cssquery-ext.html) 09:55:35 INFO - PROCESS | 24116 | RSS: Main: 240164864 09:55:35 INFO - PROCESS | 24116 | 09:58:38 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:51261/tests/dromaeo/cssquery-ext.html (next: http://localhost:51261/tests/dromaeo/cssquery-jquery.html) 09:58:38 INFO - PROCESS | 24116 | RSS: Main: 223117312 09:58:38 INFO - PROCESS | 24116 | 10:01:40 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:51261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51261/tests/dromaeo/cssquery-mootools.html) 10:01:41 INFO - PROCESS | 24116 | RSS: Main: 233439232 10:01:41 INFO - PROCESS | 24116 | 10:04:43 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:51261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51261/tests/dromaeo/cssquery-prototype.html) 10:04:43 INFO - PROCESS | 24116 | RSS: Main: 217128960 10:04:43 INFO - PROCESS | 24116 | 10:07:46 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:51261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51261/tests/dromaeo/cssquery-yui.html) 10:07:47 INFO - PROCESS | 24116 | RSS: Main: 174772224 10:07:47 INFO - PROCESS | 24116 | 10:10:49 INFO - PROCESS | 24116 | Cycle 1(1): loaded http://localhost:51261/tests/dromaeo/cssquery-yui.html (next: http://localhost:51261/tests/dromaeo/cssquery-dojo.html) 10:10:49 INFO - PROCESS | 24116 | RSS: Main: 274235392 10:10:49 INFO - PROCESS | 24116 | 10:10:49 INFO - PROCESS | 24116 | __start_tp_report 10:10:49 INFO - PROCESS | 24116 | _x_x_mozilla_page_load 10:10:49 INFO - PROCESS | 24116 | _x_x_mozilla_page_load_details 10:10:49 INFO - PROCESS | 24116 | |i|pagename|runs| 10:10:49 INFO - PROCESS | 24116 | |0;dojo.html;3121.1728891843663;3164.6518882922887;3170.873165073397;3183;3206.2625596112894;5469.726513674315;5580.330360356757;5587.944120558804;5597.216389705444;5602.663840169593;5506.504414602685;5579.9163012554745;5580.525655319303;5587.7485513151905;5616.101423772197;5037.143685573443;5055.949440505585;5095.3376061112;5112.923306150392;5115.641905066647;4892.168331383673;4944.233643785219;4986.202207646777;5061.797528098871;5108.1060814357525;5028.4971502849785;5094.592432605383;5099.821506247282;5110.616703747215;5124.026434977342;5078.5937125029905;5100.770465329069;5106.131957567222;5127.282180494733;5155.278261043457;4874.46380898101;4886.755662216875;5036.748162591855;5051.823186188502;5097.898042039138;5351.117065684158;5374.4894235048;5410.323709536308;5418.268533747933;5468.890622187574;5837.241158649391;5854.970725146347;5889.4993925515955;5938;5939.703014849283;5773.913391299134;5963.493103086243;5980.581359304851;5987.281526216838;5999.850003749898;5446.373667028263;5460.754266058037;5501.202325662796;5506.449355064461;5521.420250873681;6056.788012419544;6059.909101363483;6061.3029501607;6062.666553339609;6067.393260673985;5674.801381951612;5842.59101862874;5842.766289348463;5848.853778655568;5852;5776.480116789509;5849;5890.823275301748;5897.292324921037;5951.464368206882;5859.1797148399255;5902.173695682608;5907.763689452374;5908.261467316585;5912.024515954905;5894.086416605433;5896.587238893322;5898.587098903122;5906.5570082244;5922.170896074553;4462.397576327219;4484.349769283435;4488.326750987313;4492.528284530077;4507.121111383314;4025.19496100781;4028.093678922219;4029.6776257899296;4037.1320166164414;4059.411385349108;5530.861728456821;5581.609287349927;5595.104783234744;5596.4403559644525;5619.381867994517;5795.304563452412;5798.333191682926;5843.912341314799;5850.5612079094235;5933.406659334032;5485.643433176911;5546.473085056913;5576.275084239023;5583.916241256385;5586.636868603528;5034.244863270539;5040.546350828443;5042.39491261051;5048.469910659402;5078.4667609900425;5889.411058894077;5965.194698715704;6008.819735407945;6025.186599809057;6025.548083893638;5817.592768506164;5846.503047241032;5879.647221166743;5902.527797776082;6000.8799824004145;6022.879542409215;6084.178635884099;6089.847753806191;6090.390960903874;6092.939070609237;5843.678597676999;5844.620099693507;5846.35690074083;5849.970750146222;5851.21008663825;5644.88710225785;5769.74036168365;5832.883342333214;5852.707364631666;5892.263467066617;5822.94177058224;5839.270091238595;5842.883142337215;5843.7370318336625;5880.8235752927485;5806.158107074535;5811;5813.447722466359;5815.9709201453725;5833.154192641959;5537.750801213874;5550.47270509301;5625.915611265917;5645.4072322405555;5784.623999440023;5744.741486633196;5756.539476841926;5777.7977770777825;5780.075187969905;5814.94185058144;5551.583631227755;5621.269234999588;5621.662700237999;5621.915671264853;5628.774849005994 10:10:49 INFO - PROCESS | 24116 | |1;ext.html;574.2792795042221;620.2556931681981;642.8746394453082;647.7085311609777;650.6681592387881;34246.31507369854;34587.65412345876;43717.12565748687;44727.77636111815;44820.551794482046;42578.574214257846;45603;45617;45617.7719111404;45683.54316456834;8301.875471867927;8862.512561809099;9026.638934442615;9027.277817774595;9037.728868133967;8474.364422668294;10747.871473495288;11040.668779936615;11046.613368532104;11051.72370690735;10842.349459032444;10874.782504349947;10906.34561926283;10910.945445272802;10914.890851091466;10721;10783.245172837904;10783.460826958699;10795.5681772729;10796.67609971702;10605;10634.042936135786;10656.20078494116;10677.25259231854;10682.839757403644;41535.792321038505;41772.582274177475;41888.581114188775;41943.79028104871;41995.7900210497;3740.6259374062647;3746.044758586543;3809.9238015239816;3839.865604703822;3867.9806600966817;31214.53178202329;31348.21629459259;31512.527312090337;31617.8419107903;31773.52339714906;4290.270653988799;4348.717333373321;4410.933835992462;4423.270160423526;4491.056878055612;337109.99999999756;337131;337704;338797;340654;59823.102653460235;60092.699536502914;60131;60240;60419;39016.6098339013;39751.40372894409;40005.39991900124;42244.1551168981;42257.78871105625;16372.181390930406;16533.50399488017;16542.172891355385;16549.420770272984;16551.75172372391;11653.30080195191;11671.12466564994;11930.642080737593;12271.325077120844;12373.381330933418;18883.62232755337;19593.41549873457;19760.308389206308;19761.40715778529;19845;7000.649967501605;7099.290070992963;7188.2325304757;7256.637168141572;7294.708211671474;946.6024269806697;1028.6965345223177;1038.566777846582;1059.3485006720966;1075.800976819291;31320;32771.1807204817;32881.3423731524;32960;33553.16117097043;1129.8757136714955;1139.3562637110006;1146.18620779246;1192.284629222477;1207.8309036734863;13395.397207125703;16557.58606034859;18692.53268668267;18756.343527976456;19176.564527398055;505227;506028;506810;506917;508973;60551.394486054574;61329.693351533846;61445.38554614397;61466;61476.077858832155;1294.7086905446388;1360.1159246489663;1380.9447622095204;1407.3385508810843;1426.600551845485;27860.44279114447;30267.394652107276;30513.84743076359;30781.69218307788;30944.381112378076;57905;58836.117458239016;58878.116828246755;58910.41089589049;58915.11627325508;465798;468224;469115;469162;469944;26882.59676104899;27597.172084837486;29211.7078829209;29885.252868678457;30310.54534181945;47893;47927.5207247923;47937.5206247947;48046.27930581114;48229.75885120552;40232.195356093296;40558.39162412625;40943;41051.794741026104;42275.57724422839;41012;41370.379444308965;41981.79009104935;42316.94207644834;42339.670104930745;40417;40586.1882762349;41069.1786164281;41110;41126;34842;37023;37811.43282850814;38056;38079.428808568446;26008.73991260063;27894.44211115807;28267.71732282651;28316.716832831407;28958.855205723838 10:10:49 INFO - PROCESS | 24116 | |2;jquery.html;414.3411974959813;425.5552947170205;434.6894114245548;435.7124297963344;436.7510519004167;18609.25562977481;19063.90468047658;20207.19171233149;20267.189312427505;20341.796582034174;19408.320708775194;19836.107375168114;19925.701114483294;20415.183392664312;20607.793922060773;5554;5833.270841144857;5841.8831623367505;5848.239728835246;5855.970720146393;5535.750891209885;5633.6619802811965;5729.598928075036;5735.541156707453;5740;5758.078707406816;5761.049426844586;5770.538356931435;5776.480116789488;5784.537237021028;5566.610337276372;5720.456556627114;5757.625754325997;5770.509506691937;5771.365149833536;5176.611754118456;5192.740362981874;5196.870078248036;5199.376074871039;5199.844004679866;24077.518449631083;24255.87872060646;24394.26817195487;24410.267691969093;24471.632925506132;2490.663760392342;2503.7856639529814;2514.6228065790096;2515.2705715342527;2614.75159859813;14387.136771793726;14980.400783968627;15103.773443398359;15182.392704291815;15334.309956052004;1918.673825449663;1984.3154111831395;1997.2510308634262;2045.1921491011117;2045.795420457957;81566;82062.58968705178;83173.16826831775;83725.58137209337;85890.14109858884;9563.187129093965;9965.750856228507;10067.748306292255;10644.89355106439;10813.351198928089;14540.982131250923;14557.490487832874;14621.195834229007;14686;14694.338754756061;7777.533347999138;7819.178986206366;7988.480748751313;8062.113167551564;8103.068147163034;7725.690972361155;7736.690532378754;7776.222377762178;7934.682612695427;7934.761957141295;4435.179491794029;4453;4492.258777301774;4495.123450927038;4577.130345234395;2100.579884023171;2154.2137119951103;2154.3106206013927;2158.7409510858797;2162;963.8072385522923;991.9603215871429;1032.607609108549;1036.6216331039116;1052.7157667429751;18860.811391886178;18917.7162342565;20152.89923550402;20304.796952030585;20594.588108237753;981.9263555233243;992.846108853129;1009.7879445316419;1030.3920686794827;1075.2795626929976;10635.52140153695;11186.466052848396;11209.21535492524;11268.351937294728;11302.43487825622;445352;450213;463821;465903;468404;91236.54381728181;91536;94336.52831735798;95285;99916;1002.8395456726888;1033.4625994482976;1065.3820783945293;1071.757932254935;1084.511969613677;17491.47525574235;17811.376601818873;17906.194221260335;17964;18476.630467390307;40458;40891.97770055773;41280.58719412767;41551.79224103981;42129.78935105305;56497.43502565086;58315.70842145932;58408.70795645995;58508.122378165215;58598.41401585929;8931.285497160341;9021.458712477272;9084.636614535344;9189;9229.617802614455;7581.029480673568;11006.614768483065;12735.426905789447;14153.150810951376;14203.28983550839;11895.464704088165;12096.274223546616;12502.87497125017;12683;13099.607011789662;11837.408129593314;12105.878941210474;12157.69605759863;12400.255984640951;12479.313637749648;12077.779943329368;12151.75696486083;12294.20087694297;12410.193337433038;12600;8850.690225842065;9104.453732776055;9172.31207659415;9307.627694892128;9606.807863842823;9674.613015479303;12056.939715301367;12646.683832904251;12659.746805064031;12679.556215532411 10:10:49 INFO - PROCESS | 24116 | |3;mootools.html;1388.396047719243;1504.052446958416;1529.9005564638298;1694.9576260593483;1824.8448881845043;7478.887816682754;8002.919970800291;8282.751517454479;8302.584870756453;8529.829403411928;8312.501249925008;8341.45780524267;8385.329173666107;8386.790330241733;8426.199511046441;2395.5568219879333;2432.4526981429212;2435.8538487690707;2446.1805295226122;2452.6075827867544;2374.25211058516;2390.796782273509;2470.5923522618837;2481.4292712676097;2482.354587807174;2379.3218932604213;2402.5435167318155;2415.5048215115858;2451.2156110044793;2453.251758213744;2296.3111066680094;2310.306907927615;2332.4052366646565;2336.532693461306;2337.4857531343077;2337.836351455399;2348.8708121053337;2354.0348457132663;2358.811295096388;2367.538330025646;8203.466774659688;8295;8469.49183049013;8481.575921203977;8494.915050849475;5122.33409656746;5339.225812257239;5355.357357117171;5358.3569971603265;5363.54409875161;3488.476728490721;3610.0433385152955;3618.131648404364;3688.870889518854;3689.096171438015;1102.200904344352;1106.8505751723494;1122.1359553144034;1148.5520646947698;1153.0832987774738;11471.369074700888;11477.483513241925;11564.074874010059;11584.826227606593;11588.188826782212;4245.150969805989;4528.139653465831;4604.194266003436;4608.631309495299;4629.3518907353;9269.814603708022;9278.907210927804;9285.675001375055;9292.90707092934;9294.488803115759;5273.525382715574;5277.23480095384;5279.973600131974;5281.735913204325;5285.127953887565;4388.188185185751;4395.516493185747;4840.2255639098275;4875.366202393737;4937.407511098691;3803.82882770276;3865.207632435344;3944.9605503944595;3958.188571342868;3962.841486340572;1219.3354621731178;1220.2373516552154;1229.9606832226755;1230.6431134970758;1239.6962744127748;1002.4486532407146;1013.3362647465922;1030.5002073994256;1035.2184101003695;1048.7692707604315;5773.624714393635;5916.437938395846;5971.58198926071;6036.3058248302;6193.040078787795;923.676713150392;939.4363381970763;945.2768631996528;988.604558176735;997.9301448898652;3714.2200137971327;4034.293998550242;4071.3892916062237;4185.351270553069;4247.171801498678;9972.102510774064;10100.292979491513;10186.388816671024;10341.74145646365;10365.533550990223;10279.794404111875;10298.485075746332;10298.691039268833;10315.1747860171;10316;7522.134954480195;7834.843303134019;7894.802629934297;7896.486728362638;7902.249286317906;5625.156226565884;5648.096304591246;5704;5713.885722285614;5783.94216057834;9507.239420846454;9571.664991725256;9636.614535418785;9682.709518714168;9730.464824434725;9206.953965230132;9517.428954262767;9526.237900967768;9722.902770972483;9723.46520941355;6559.639219842955;6726.529142959946;7280.235575264521;7520.210377910241;7682.846343073219;7853.842923141619;8193.34453243751;8204.548749818818;8206.876896846672;8210.3021243195;7066.399356054793;7222.819429514304;7263.382612477787;7282.817929551804;7313.817154571178;6992.930070699228;7197.532160409557;7267.091613548307;7275.8181045472165;7393.07586551681;6683.799486015428;6807.5575087619145;6814.829629259309;6816.182058153054;6833.89749153773;4838;5068.898622027465;5151.381834179772;5156.458571850052;5162.406323272871;4804.807807687654;4947.109520286383;4956.504349565159;5003.774075351562;5063.265826455217 10:10:49 INFO - PROCESS | 24116 | |4;prototype.html;340.2599346421534;340.40429248814576;346.4941185868632;357.7549378675607;362.2411048852654;5342.786288548458;5354.22363757256;5376.596755243362;5401.378841433237;5407.702576358299;5060.41805192403;5143.588512918966;5182.352205974254;5200.297959775429;5300.144949267755;4174.039970806716;4176.791160441966;4180.832766689329;4197.2444959907125;4197.328427451608;4216.936745948813;4217.536071032184;4218.303979843322;4232.280512312914;4234.771916144315;3973.960260397402;3974;4120.958790412087;4155.563665815092;4233.830646774125;4135.958640413603;4144.647704945083;4151.543330233671;4158.708890377675;4161.875143745692;3700.0009997300576;3710.7588006779474;3716.572594151653;3716.832742526593;3718.6839118674943;5075.777599353667;5185.662931909414;5209.557187639055;5218.112920803473;5237.685738855681;4741.525847415231;4764.880877978044;4769.332293478916;4776.686411236903;4780.235162374003;5536.505143611243;5549.500544950974;5553.722313884289;5565.5825813063775;5570.442955704438;3958.307296223178;4064.288749468831;4094.6282995196643;4128.504579450485;4131.938020929689;5685.953056899513;5704.600677952503;5737.942620573783;5743.282089738783;5746.655200687972;4143.1713657268665;4147.274227010261;4156.625903668684;4192.769397683096;4206.8527601534415;4077.4699289092823;4198.118395137056;4231.280682284019;4237.216115018731;4247.193033323659;4744.217204161344;4756.262779269219;4757.785899634525;4768.61851051915;4789.4971028042255;5558.833235002957;5559.054960656698;5561.4716601922755;5567.693776842231;5581.358143813432;1391.522462935039;1442.4158215922569;1443.444273954514;1447.2835946206694;1449.8840092792552;1013.8732658417698;1018.3279035836313;1032.0762917189074;1032.726327523207;1034.984475232872;5099.184130539096;5158.613104017214;5159.406668233201;5166.61250406221;5181.948180518147;5470.53500452466;5484.670919744828;5486.231927530149;5489.3531940417715;5519.558435325164;5103.438621751604;5140.30605868203;5143.894062776521;5149.433562308143;5181.611379146504;2911.7088291171135;2943.7203465670727;2944.617199764017;2948.3366242595243;2977.243426378447;5711;5724.427557244242;5729.455701708331;5738.225339579187;5764.550066221923;5435.891282174334;5542.39033706292;5637.295338082739;5675.829725108253;5706.71466426677;5592.664440133686;5671.6597004179885;5675.432456754292;5685.005124103265;5706.743196556165;5303.496167864047;5501.972490137684;5556.277683901067;5559.722013899208;5579.442055794388;5427.918581221364;5441.020616289106;5459.461350472049;5462.235287059735;5474.288342515448;5534.335879694462;5608.7380339424935;5658.264425624807;5672.829815105553;5699.202111704281;3982.26328129297;4095.0720235032095;4098.897527561835;4104.610062044101;4111.383292506148;5484.396716361277;5519.39286678473;5596.524295434933;5608.635438696471;5610.747516361692;5468.261784659179;5487.862803429946;5520.420355862577;5624.775008999594;5640.689762063126;5495.642783219078;5546.750396232099;5592.3009623797025;5605.831825045255;5608.775648974159;5532.806351777668;5541.889162216652;5565.805196818092;5600.131979543177;5605.187247848958;5596.272484576979;5620;5640.971795140998;5649.096144616841;5652;5242.68543887368;5481.437790229766;5497.3952865184;5535.612507124462;5548.528375088163 10:10:49 INFO - PROCESS | 24116 | |5;yui.html;784.1178673991759;788.2235997542423;789.3527307607764;855.8844555984942;870.7866572689692;15031.398744050239;15241.237938103106;15979.121148336837;16184.676306473893;16249.350025998945;13023.869761302383;13940.442382304722;14036.368363423644;14042.08726432781;14415.351309191085;828.7472320942126;838.8238469921293;843.6667516331046;845.9069502354736;847.220557087481;832.6086739232551;835.0605568735173;835.5446281776416;835.8579041562919;835.9289460395843;877.9517126558037;878.4597472554397;878.8286284174557;880.2429910277189;880.6301353431542;873.2839071960931;873.9650413983433;874.33113668044;874.7463235661651;874.8687696845492;644.7614382678393;645.2869579115057;645.6255371884296;646.205167643796;646.6863571167979;13046.412911418915;13064.477420903153;14236.501722439769;14509.854901450955;14658;14180.361883715257;14244.287785610679;14526.636834079232;14554.563363099123;14958.775618365733;11659;12021.759564808655;12024.759504809943;12234;12552.560660376934;3762.454444105617;3767.9811600942094;3775.6035616260447;3782.243551289753;3812.504374431306;64726.3527364725;64767.352326476605;64940;65004.67497662482;65819;10522;10793.40636265013;10806.297590656583;11025.724356890982;11161.83257251142;20745.27391541319;20789;20825.79174208269;20829.68755468669;20836.791632083787;8473.322134229247;8507.532085735344;8531.146885311418;8563.95718021406;8573.74278771638;4396.736195828261;4664.3936288282985;4771.5228477152705;4898.24077268024;4954.677945933575;3538.380783362901;3647.252313275772;3647.9270414592092;3649.9817500912327;3656.067702735785;551.4292707048266;620.6772478311343;627.5356236385043;627.8367624417684;629.351767679291;703.3494018033299;738.3834498194068;747.5253214209016;764.8317370178552;800.855845947735;9378;9812.74306909415;9855.950720246354;10633.361998280128;10639.840402393971;705.2383425900016;722.9313215244543;729.6060127531074;784.4576234206743;785.6386062411354;4671.883202919887;4810.326554282403;4855.295982082578;4865.95134048662;4949.232868905254;51574.74212628988;51980;52470;53275.73362133242;56480;71047.28952710406;72903.27096728965;73938.63030684812;74601.62699186469;75162;67046.66476667585;67386.32613673898;67885.32114678889;68086;68857.999999999;9778.119969202806;10103.393796372242;10189.184865210616;10198.286119971532;10279.743006424898;44823;45345.773271134756;45446.77276613596;45818.5569669228;46678;63280.68359658172;64376;64381.67809161112;65713;66800.6659966697;12330.075244356529;12496.500139994298;12588.244705317711;12640.494380224687;12953.870461295266;13878.89257941083;14088.22514761657;14116.576502704935;14297.142171469744;14425.918056145621;13378;13696.452141914211;13866.930665346608;14292.785608216092;14561.126332420088;13241.602751917459;13261.933690331487;13261.933690331487;13911.304434778423;14312;13560.93219533896;13638.249896255802;14111.929440352733;14403.495877644233;14592.270386480846;9899.554520046471;9963.950180249052;10344.120749736358;10446.63436779709;10537;9802.970688077934;10443.375270198781;10889.618863339745;10963.890361096286;11056.834147487632 10:10:49 INFO - PROCESS | 24116 | __end_tp_report 10:10:49 INFO - PROCESS | 24116 | __start_cc_report 10:10:49 INFO - PROCESS | 24116 | _x_x_mozilla_cycle_collect,988 10:10:49 INFO - PROCESS | 24116 | __end_cc_report 10:10:49 INFO - PROCESS | 24116 | __startTimestamp1479751849523__endTimestamp 10:10:49 INFO - PROCESS | 24116 | 10:10:49 INFO - PROCESS | 24116 | ------- Summary: start ------- 10:10:49 INFO - PROCESS | 24116 | Number of tests: 6 10:10:49 INFO - PROCESS | 24116 | 10:10:49 INFO - PROCESS | 24116 | [#0] dojo.html Cycles:165 Average:5475.32 Median:5628.77 stddev:616.80 (11.0%) stddev-sans-first:590.40 10:10:49 INFO - PROCESS | 24116 | Values: 3121.2 3164.7 3170.9 3183.0 3206.3 5469.7 5580.3 5587.9 5597.2 5602.7 5506.5 5579.9 5580.5 5587.7 5616.1 5037.1 5055.9 5095.3 5112.9 5115.6 4892.2 4944.2 4986.2 5061.8 5108.1 5028.5 5094.6 5099.8 5110.6 5124.0 5078.6 5100.8 5106.1 5127.3 5155.3 4874.5 4886.8 5036.7 5051.8 5097.9 5351.1 5374.5 5410.3 5418.3 5468.9 5837.2 5855.0 5889.5 5938.0 5939.7 5773.9 5963.5 5980.6 5987.3 5999.9 5446.4 5460.8 5501.2 5506.4 5521.4 6056.8 6059.9 6061.3 6062.7 6067.4 5674.8 5842.6 5842.8 5848.9 5852.0 5776.5 5849.0 5890.8 5897.3 5951.5 5859.2 5902.2 5907.8 5908.3 5912.0 5894.1 5896.6 5898.6 5906.6 5922.2 4462.4 4484.3 4488.3 4492.5 4507.1 4025.2 4028.1 4029.7 4037.1 4059.4 5530.9 5581.6 5595.1 5596.4 5619.4 5795.3 5798.3 5843.9 5850.6 5933.4 5485.6 5546.5 5576.3 5583.9 5586.6 5034.2 5040.5 5042.4 5048.5 5078.5 5889.4 5965.2 6008.8 6025.2 6025.5 5817.6 5846.5 5879.6 5902.5 6000.9 6022.9 6084.2 6089.8 6090.4 6092.9 5843.7 5844.6 5846.4 5850.0 5851.2 5644.9 5769.7 5832.9 5852.7 5892.3 5822.9 5839.3 5842.9 5843.7 5880.8 5806.2 5811.0 5813.4 5816.0 5833.2 5537.8 5550.5 5625.9 5645.4 5784.6 5744.7 5756.5 5777.8 5780.1 5814.9 5551.6 5621.3 5621.7 5621.9 5628.8 10:10:49 INFO - PROCESS | 24116 | 10:10:49 INFO - PROCESS | 24116 | [#1] ext.html Cycles:180 Average:59940.92 Median:38067.71 stddev:117512.96 (308.7%) stddev-sans-first:117758.08 10:10:49 INFO - PROCESS | 24116 | Values: 574.3 620.3 642.9 647.7 650.7 34246.3 34587.7 43717.1 44727.8 44820.6 42578.6 45603.0 45617.0 45617.8 45683.5 8301.9 8862.5 9026.6 9027.3 9037.7 8474.4 10747.9 11040.7 11046.6 11051.7 10842.3 10874.8 10906.3 10910.9 10914.9 10721.0 10783.2 10783.5 10795.6 10796.7 10605.0 10634.0 10656.2 10677.3 10682.8 41535.8 41772.6 41888.6 41943.8 41995.8 3740.6 3746.0 3809.9 3839.9 3868.0 31214.5 31348.2 31512.5 31617.8 31773.5 4290.3 4348.7 4410.9 4423.3 4491.1 337110.0 337131.0 337704.0 338797.0 340654.0 59823.1 60092.7 60131.0 60240.0 60419.0 39016.6 39751.4 40005.4 42244.2 42257.8 16372.2 16533.5 16542.2 16549.4 16551.8 11653.3 11671.1 11930.6 12271.3 12373.4 18883.6 19593.4 19760.3 19761.4 19845.0 7000.6 7099.3 7188.2 7256.6 7294.7 946.6 1028.7 1038.6 1059.3 1075.8 31320.0 32771.2 32881.3 32960.0 33553.2 1129.9 1139.4 1146.2 1192.3 1207.8 13395.4 16557.6 18692.5 18756.3 19176.6 505227.0 506028.0 506810.0 506917.0 508973.0 60551.4 61329.7 61445.4 61466.0 61476.1 1294.7 1360.1 1380.9 1407.3 1426.6 27860.4 30267.4 30513.8 30781.7 30944.4 57905.0 58836.1 58878.1 58910.4 58915.1 465798.0 468224.0 469115.0 469162.0 469944.0 26882.6 27597.2 29211.7 29885.3 30310.5 47893.0 47927.5 47937.5 48046.3 48229.8 40232.2 40558.4 40943.0 41051.8 42275.6 41012.0 41370.4 41981.8 42316.9 42339.7 40417.0 40586.2 41069.2 41110.0 41126.0 34842.0 37023.0 37811.4 38056.0 38079.4 26008.7 27894.4 28267.7 28316.7 28958.9 10:10:49 INFO - PROCESS | 24116 | 10:10:49 INFO - PROCESS | 24116 | [#2] jquery.html Cycles:180 Average:28506.78 Median:2565.01 stddev:75896.16 (2958.9%) stddev-sans-first:76079.76 10:10:49 INFO - PROCESS | 24116 | Values: 414.3 425.6 434.7 435.7 436.8 18609.3 19063.9 20207.2 20267.2 20341.8 19408.3 19836.1 19925.7 20415.2 20607.8 5554.0 5833.3 5841.9 5848.2 5856.0 5535.8 5633.7 5729.6 5735.5 5740.0 5758.1 5761.0 5770.5 5776.5 5784.5 5566.6 5720.5 5757.6 5770.5 5771.4 5176.6 5192.7 5196.9 5199.4 5199.8 24077.5 24255.9 24394.3 24410.3 24471.6 2490.7 2503.8 2514.6 2515.3 2614.8 14387.1 14980.4 15103.8 15182.4 15334.3 1918.7 1984.3 1997.3 2045.2 2045.8 81566.0 82062.6 83173.2 83725.6 85890.1 9563.2 9965.8 10067.7 10644.9 10813.4 14541.0 14557.5 14621.2 14686.0 14694.3 7777.5 7819.2 7988.5 8062.1 8103.1 7725.7 7736.7 7776.2 7934.7 7934.8 4435.2 4453.0 4492.3 4495.1 4577.1 2100.6 2154.2 2154.3 2158.7 2162.0 963.8 992.0 1032.6 1036.6 1052.7 18860.8 18917.7 20152.9 20304.8 20594.6 981.9 992.8 1009.8 1030.4 1075.3 10635.5 11186.5 11209.2 11268.4 11302.4 445352.0 450213.0 463821.0 465903.0 468404.0 91236.5 91536.0 94336.5 95285.0 99916.0 1002.8 1033.5 1065.4 1071.8 1084.5 17491.5 17811.4 17906.2 17964.0 18476.6 40458.0 40892.0 41280.6 41551.8 42129.8 56497.4 58315.7 58408.7 58508.1 58598.4 8931.3 9021.5 9084.6 9189.0 9229.6 7581.0 11006.6 12735.4 14153.2 14203.3 11895.5 12096.3 12502.9 12683.0 13099.6 11837.4 12105.9 12157.7 12400.3 12479.3 12077.8 12151.8 12294.2 12410.2 12600.0 8850.7 9104.5 9172.3 9307.6 9606.8 9674.6 12056.9 12646.7 12659.7 12679.6 10:10:49 INFO - PROCESS | 24116 | 10:10:49 INFO - PROCESS | 24116 | [#3] mootools.html Cycles:180 Average:5574.42 Median:5095.62 stddev:3026.66 (59.4%) stddev-sans-first:3018.80 10:10:49 INFO - PROCESS | 24116 | Values: 1388.4 1504.1 1529.9 1695.0 1824.8 7478.9 8002.9 8282.8 8302.6 8529.8 8312.5 8341.5 8385.3 8386.8 8426.2 2395.6 2432.5 2435.9 2446.2 2452.6 2374.3 2390.8 2470.6 2481.4 2482.4 2379.3 2402.5 2415.5 2451.2 2453.3 2296.3 2310.3 2332.4 2336.5 2337.5 2337.8 2348.9 2354.0 2358.8 2367.5 8203.5 8295.0 8469.5 8481.6 8494.9 5122.3 5339.2 5355.4 5358.4 5363.5 3488.5 3610.0 3618.1 3688.9 3689.1 1102.2 1106.9 1122.1 1148.6 1153.1 11471.4 11477.5 11564.1 11584.8 11588.2 4245.2 4528.1 4604.2 4608.6 4629.4 9269.8 9278.9 9285.7 9292.9 9294.5 5273.5 5277.2 5280.0 5281.7 5285.1 4388.2 4395.5 4840.2 4875.4 4937.4 3803.8 3865.2 3945.0 3958.2 3962.8 1219.3 1220.2 1230.0 1230.6 1239.7 1002.4 1013.3 1030.5 1035.2 1048.8 5773.6 5916.4 5971.6 6036.3 6193.0 923.7 939.4 945.3 988.6 997.9 3714.2 4034.3 4071.4 4185.4 4247.2 9972.1 10100.3 10186.4 10341.7 10365.5 10279.8 10298.5 10298.7 10315.2 10316.0 7522.1 7834.8 7894.8 7896.5 7902.2 5625.2 5648.1 5704.0 5713.9 5783.9 9507.2 9571.7 9636.6 9682.7 9730.5 9207.0 9517.4 9526.2 9722.9 9723.5 6559.6 6726.5 7280.2 7520.2 7682.8 7853.8 8193.3 8204.5 8206.9 8210.3 7066.4 7222.8 7263.4 7282.8 7313.8 6992.9 7197.5 7267.1 7275.8 7393.1 6683.8 6807.6 6814.8 6816.2 6833.9 4838.0 5068.9 5151.4 5156.5 5162.4 4804.8 4947.1 4956.5 5003.8 5063.3 10:10:49 INFO - PROCESS | 24116 | 10:10:49 INFO - PROCESS | 24116 | [#4] prototype.html Cycles:180 Average:4652.04 Median:5204.93 stddev:1330.94 (25.6%) stddev-sans-first:1294.73 10:10:49 INFO - PROCESS | 24116 | Values: 340.3 340.4 346.5 357.8 362.2 5342.8 5354.2 5376.6 5401.4 5407.7 5060.4 5143.6 5182.4 5200.3 5300.1 4174.0 4176.8 4180.8 4197.2 4197.3 4216.9 4217.5 4218.3 4232.3 4234.8 3974.0 3974.0 4121.0 4155.6 4233.8 4136.0 4144.6 4151.5 4158.7 4161.9 3700.0 3710.8 3716.6 3716.8 3718.7 5075.8 5185.7 5209.6 5218.1 5237.7 4741.5 4764.9 4769.3 4776.7 4780.2 5536.5 5549.5 5553.7 5565.6 5570.4 3958.3 4064.3 4094.6 4128.5 4131.9 5686.0 5704.6 5737.9 5743.3 5746.7 4143.2 4147.3 4156.6 4192.8 4206.9 4077.5 4198.1 4231.3 4237.2 4247.2 4744.2 4756.3 4757.8 4768.6 4789.5 5558.8 5559.1 5561.5 5567.7 5581.4 1391.5 1442.4 1443.4 1447.3 1449.9 1013.9 1018.3 1032.1 1032.7 1035.0 5099.2 5158.6 5159.4 5166.6 5181.9 5470.5 5484.7 5486.2 5489.4 5519.6 5103.4 5140.3 5143.9 5149.4 5181.6 2911.7 2943.7 2944.6 2948.3 2977.2 5711.0 5724.4 5729.5 5738.2 5764.6 5435.9 5542.4 5637.3 5675.8 5706.7 5592.7 5671.7 5675.4 5685.0 5706.7 5303.5 5502.0 5556.3 5559.7 5579.4 5427.9 5441.0 5459.5 5462.2 5474.3 5534.3 5608.7 5658.3 5672.8 5699.2 3982.3 4095.1 4098.9 4104.6 4111.4 5484.4 5519.4 5596.5 5608.6 5610.7 5468.3 5487.9 5520.4 5624.8 5640.7 5495.6 5546.8 5592.3 5605.8 5608.8 5532.8 5541.9 5565.8 5600.1 5605.2 5596.3 5620.0 5641.0 5649.1 5652.0 5242.7 5481.4 5497.4 5535.6 5548.5 10:10:49 INFO - PROCESS | 24116 | 10:10:49 INFO - PROCESS | 24116 | [#5] yui.html Cycles:180 Average:17051.24 Median:4721.70 stddev:21112.09 (447.1%) stddev-sans-first:21135.97 10:10:49 INFO - PROCESS | 24116 | Values: 784.1 788.2 789.4 855.9 870.8 15031.4 15241.2 15979.1 16184.7 16249.4 13023.9 13940.4 14036.4 14042.1 14415.4 828.7 838.8 843.7 845.9 847.2 832.6 835.1 835.5 835.9 835.9 878.0 878.5 878.8 880.2 880.6 873.3 874.0 874.3 874.7 874.9 644.8 645.3 645.6 646.2 646.7 13046.4 13064.5 14236.5 14509.9 14658.0 14180.4 14244.3 14526.6 14554.6 14958.8 11659.0 12021.8 12024.8 12234.0 12552.6 3762.5 3768.0 3775.6 3782.2 3812.5 64726.4 64767.4 64940.0 65004.7 65819.0 10522.0 10793.4 10806.3 11025.7 11161.8 20745.3 20789.0 20825.8 20829.7 20836.8 8473.3 8507.5 8531.1 8564.0 8573.7 4396.7 4664.4 4771.5 4898.2 4954.7 3538.4 3647.3 3647.9 3650.0 3656.1 551.4 620.7 627.5 627.8 629.4 703.3 738.4 747.5 764.8 800.9 9378.0 9812.7 9856.0 10633.4 10639.8 705.2 722.9 729.6 784.5 785.6 4671.9 4810.3 4855.3 4866.0 4949.2 51574.7 51980.0 52470.0 53275.7 56480.0 71047.3 72903.3 73938.6 74601.6 75162.0 67046.7 67386.3 67885.3 68086.0 68858.0 9778.1 10103.4 10189.2 10198.3 10279.7 44823.0 45345.8 45446.8 45818.6 46678.0 63280.7 64376.0 64381.7 65713.0 66800.7 12330.1 12496.5 12588.2 12640.5 12953.9 13878.9 14088.2 14116.6 14297.1 14425.9 13378.0 13696.5 13866.9 14292.8 14561.1 13241.6 13261.9 13261.9 13911.3 14312.0 13560.9 13638.2 14111.9 14403.5 14592.3 9899.6 9964.0 10344.1 10446.6 10537.0 9803.0 10443.4 10889.6 10963.9 11056.8 10:10:49 INFO - PROCESS | 24116 | -------- Summary: end -------- 10:10:49 INFO - PROCESS | 24116 | 10:10:50 INFO - TEST-INFO | 24116: exit 0 10:10:50 INFO - TEST-OK | dromaeo_css | took 1114254ms 10:10:50 INFO - TEST-START | kraken 10:10:50 INFO - operating with platform_type : linux_ 10:10:50 INFO - Initialising browser for kraken test... 10:10:50 INFO - TEST-INFO | started process 24436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgHuEo/profile http://localhost:51261/getInfo.html) 10:10:53 ERROR - PROCESS | 24436 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 10:10:54 INFO - PROCESS | 24436 | __metrics Screen width/height:1600/1200 10:10:54 INFO - PROCESS | 24436 | colorDepth:24 10:10:54 INFO - PROCESS | 24436 | Browser inner width/height: 1024/697 10:10:54 INFO - PROCESS | 24436 | __metrics 10:10:54 INFO - PROCESS | 24436 | 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" 10:10:54 INFO - PROCESS | 24436 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:55 INFO - PROCESS | 24436 | console.error: PushService: 10:10:55 INFO - PROCESS | 24436 | stateChangeProcessEnqueue: Error transitioning state 10:10:55 INFO - PROCESS | 24436 | UnknownError 10:10:55 INFO - TEST-INFO | 24436: exit 0 10:10:55 INFO - Browser initialized. 10:10:55 INFO - Running cycle 1/1 for kraken test... 10:10:55 INFO - TEST-INFO | started process 24527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgHuEo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:07 INFO - PROCESS | 24527 | RSS: Main: 147984384 10:11:07 INFO - PROCESS | 24527 | 10:11:10 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51261/tests/kraken/driver.html?testName=audio-beat-detection) 10:11:11 INFO - PROCESS | 24527 | RSS: Main: 189501440 10:11:11 INFO - PROCESS | 24527 | 10:11:13 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51261/tests/kraken/driver.html?testName=audio-dft) 10:11:14 INFO - PROCESS | 24527 | RSS: Main: 178778112 10:11:14 INFO - PROCESS | 24527 | 10:11:17 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51261/tests/kraken/driver.html?testName=audio-fft) 10:11:17 INFO - PROCESS | 24527 | RSS: Main: 270315520 10:11:17 INFO - PROCESS | 24527 | 10:11:19 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51261/tests/kraken/driver.html?testName=audio-oscillator) 10:11:20 INFO - PROCESS | 24527 | RSS: Main: 176586752 10:11:20 INFO - PROCESS | 24527 | 10:11:22 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:22 INFO - PROCESS | 24527 | RSS: Main: 178208768 10:11:22 INFO - PROCESS | 24527 | 10:11:25 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51261/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:26 INFO - PROCESS | 24527 | RSS: Main: 217882624 10:11:26 INFO - PROCESS | 24527 | 10:11:29 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51261/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:30 INFO - PROCESS | 24527 | RSS: Main: 216776704 10:11:30 INFO - PROCESS | 24527 | 10:11:33 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51261/tests/kraken/driver.html?testName=json-parse-financial) 10:11:33 INFO - PROCESS | 24527 | RSS: Main: 215543808 10:11:33 INFO - PROCESS | 24527 | 10:11:35 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:35 INFO - PROCESS | 24527 | RSS: Main: 178147328 10:11:35 INFO - PROCESS | 24527 | 10:11:37 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51261/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:38 INFO - PROCESS | 24527 | RSS: Main: 185028608 10:11:38 INFO - PROCESS | 24527 | 10:11:40 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:40 INFO - PROCESS | 24527 | RSS: Main: 191066112 10:11:40 INFO - PROCESS | 24527 | 10:11:43 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:43 INFO - PROCESS | 24527 | RSS: Main: 198750208 10:11:43 INFO - PROCESS | 24527 | 10:11:46 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:47 INFO - PROCESS | 24527 | RSS: Main: 195739648 10:11:47 INFO - PROCESS | 24527 | 10:11:48 INFO - PROCESS | 24527 | Cycle 1(1): loaded http://localhost:51261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51261/tests/kraken/driver.html?testName=ai-astar) 10:11:49 INFO - PROCESS | 24527 | RSS: Main: 246726656 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | __start_tp_report 10:11:49 INFO - PROCESS | 24527 | _x_x_mozilla_page_load 10:11:49 INFO - PROCESS | 24527 | _x_x_mozilla_page_load_details 10:11:49 INFO - PROCESS | 24527 | |i|pagename|runs| 10:11:49 INFO - PROCESS | 24527 | |0;ai-astar;104;112;113;113;113;112;114;112;113;112 10:11:49 INFO - PROCESS | 24527 | |1;audio-beat-detection;145;128;122;161;124;130;123;121;149;125 10:11:49 INFO - PROCESS | 24527 | |2;audio-dft;160;160;161;161;161;162;162;161;161;162 10:11:49 INFO - PROCESS | 24527 | |3;audio-fft;74;75;76;109;76;76;76;75;97;75 10:11:49 INFO - PROCESS | 24527 | |4;audio-oscillator;83;82;115;83;83;82;98;82;82;115 10:11:49 INFO - PROCESS | 24527 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;116 10:11:49 INFO - PROCESS | 24527 | |6;imaging-darkroom;146;147;146;146;147;148;147;146;147;147 10:11:49 INFO - PROCESS | 24527 | |7;imaging-desaturate;84;85;85;86;84;85;84;85;84;85 10:11:49 INFO - PROCESS | 24527 | |8;json-parse-financial;51;51;53;50;51;51;52;51;51;50 10:11:49 INFO - PROCESS | 24527 | |9;json-stringify-tinderbox;59;61;61;61;61;61;60;60;61;60 10:11:49 INFO - PROCESS | 24527 | |10;stanford-crypto-aes;76;83;75;76;75;75;75;79;76;74 10:11:49 INFO - PROCESS | 24527 | |11;stanford-crypto-ccm;132;137;127;139;132;122;127;133;166;126 10:11:49 INFO - PROCESS | 24527 | |12;stanford-crypto-pbkdf2;158;156;156;156;154;157;158;158;157;155 10:11:49 INFO - PROCESS | 24527 | |13;stanford-crypto-sha256-iterative;63;62;63;63;63;63;63;60;60;60 10:11:49 INFO - PROCESS | 24527 | __end_tp_report 10:11:49 INFO - PROCESS | 24527 | __start_cc_report 10:11:49 INFO - PROCESS | 24527 | _x_x_mozilla_cycle_collect,1635 10:11:49 INFO - PROCESS | 24527 | __end_cc_report 10:11:49 INFO - PROCESS | 24527 | __startTimestamp1479751909086__endTimestamp 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | ------- Summary: start ------- 10:11:49 INFO - PROCESS | 24527 | Number of tests: 14 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.82 (2.5%) stddev-sans-first:0.71 10:11:49 INFO - PROCESS | 24527 | Values: 104.0 112.0 113.0 113.0 113.0 112.0 114.0 112.0 113.0 112.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:129.00 stddev:13.85 (10.7%) stddev-sans-first:13.97 10:11:49 INFO - PROCESS | 24527 | Values: 145.0 128.0 122.0 161.0 124.0 130.0 123.0 121.0 149.0 125.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 10:11:49 INFO - PROCESS | 24527 | Values: 160.0 160.0 161.0 161.0 161.0 162.0 162.0 161.0 161.0 162.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:12.00 (15.8%) stddev-sans-first:12.47 10:11:49 INFO - PROCESS | 24527 | Values: 74.0 75.0 76.0 109.0 76.0 76.0 76.0 75.0 97.0 75.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:82.50 stddev:13.80 (16.7%) stddev-sans-first:14.37 10:11:49 INFO - PROCESS | 24527 | Values: 83.0 82.0 115.0 83.0 83.0 82.0 98.0 82.0 82.0 115.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:11:49 INFO - PROCESS | 24527 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 10:11:49 INFO - PROCESS | 24527 | Values: 146.0 147.0 146.0 146.0 147.0 148.0 147.0 146.0 147.0 147.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 10:11:49 INFO - PROCESS | 24527 | Values: 84.0 85.0 85.0 86.0 84.0 85.0 84.0 85.0 84.0 85.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 10:11:49 INFO - PROCESS | 24527 | Values: 51.0 51.0 53.0 50.0 51.0 51.0 52.0 51.0 51.0 50.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.71 (1.2%) stddev-sans-first:0.50 10:11:49 INFO - PROCESS | 24527 | Values: 59.0 61.0 61.0 61.0 61.0 61.0 60.0 60.0 61.0 60.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.00 stddev:2.67 (3.5%) stddev-sans-first:2.83 10:11:49 INFO - PROCESS | 24527 | Values: 76.0 83.0 75.0 76.0 75.0 75.0 75.0 79.0 76.0 74.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:132.50 stddev:12.35 (9.3%) stddev-sans-first:13.08 10:11:49 INFO - PROCESS | 24527 | Values: 132.0 137.0 127.0 139.0 132.0 122.0 127.0 133.0 166.0 126.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:157.00 stddev:1.35 (0.9%) stddev-sans-first:1.32 10:11:49 INFO - PROCESS | 24527 | Values: 158.0 156.0 156.0 156.0 154.0 157.0 158.0 158.0 157.0 155.0 10:11:49 INFO - PROCESS | 24527 | 10:11:49 INFO - PROCESS | 24527 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:63.00 stddev:1.41 (2.2%) stddev-sans-first:1.45 10:11:49 INFO - PROCESS | 24527 | Values: 63.0 62.0 63.0 63.0 63.0 63.0 63.0 60.0 60.0 60.0 10:11:49 INFO - PROCESS | 24527 | -------- Summary: end -------- 10:11:49 INFO - PROCESS | 24527 | 10:11:50 INFO - TEST-INFO | 24527: exit 0 10:11:50 INFO - TEST-OK | kraken | took 59877ms 10:11:50 INFO - SUITE-END | took 1174s 10:11:50 INFO - Completed test suite (00:19:34) 10:11:50 INFO - javascript benchmark 10:11:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.1728891843663, 3164.6518882922887, 3170.873165073397, 3183.0, 3206.2625596112894, 5469.726513674315, 5580.330360356757, 5587.944120558804, 5597.216389705444, 5602.663840169593, 5506.504414602685, 5579.9163012554745, 5580.525655319303, 5587.7485513151905, 5616.101423772197, 5037.143685573443, 5055.949440505585, 5095.3376061112, 5112.923306150392, 5115.641905066647, 4892.168331383673, 4944.233643785219, 4986.202207646777, 5061.797528098871, 5108.1060814357525, 5028.4971502849785, 5094.592432605383, 5099.821506247282, 5110.616703747215, 5124.026434977342, 5078.5937125029905, 5100.770465329069, 5106.131957567222, 5127.282180494733, 5155.278261043457, 4874.46380898101, 4886.755662216875, 5036.748162591855, 5051.823186188502, 5097.898042039138, 5351.117065684158, 5374.4894235048, 5410.323709536308, 5418.268533747933, 5468.890622187574, 5837.241158649391, 5854.970725146347, 5889.4993925515955, 5938.0, 5939.703014849283, 5773.913391299134, 5963.493103086243, 5980.581359304851, 5987.281526216838, 5999.850003749898, 5446.373667028263, 5460.754266058037, 5501.202325662796, 5506.449355064461, 5521.420250873681, 6056.788012419544, 6059.909101363483, 6061.3029501607, 6062.666553339609, 6067.393260673985, 5674.801381951612, 5842.59101862874, 5842.766289348463, 5848.853778655568, 5852.0, 5776.480116789509, 5849.0, 5890.823275301748, 5897.292324921037, 5951.464368206882, 5859.1797148399255, 5902.173695682608, 5907.763689452374, 5908.261467316585, 5912.024515954905, 5894.086416605433, 5896.587238893322, 5898.587098903122, 5906.5570082244, 5922.170896074553, 4462.397576327219, 4484.349769283435, 4488.326750987313, 4492.528284530077, 4507.121111383314, 4025.19496100781, 4028.093678922219, 4029.6776257899296, 4037.1320166164414, 4059.411385349108, 5530.861728456821, 5581.609287349927, 5595.104783234744, 5596.4403559644525, 5619.381867994517, 5795.304563452412, 5798.333191682926, 5843.912341314799, 5850.5612079094235, 5933.406659334032, 5485.643433176911, 5546.473085056913, 5576.275084239023, 5583.916241256385, 5586.636868603528, 5034.244863270539, 5040.546350828443, 5042.39491261051, 5048.469910659402, 5078.4667609900425, 5889.411058894077, 5965.194698715704, 6008.819735407945, 6025.186599809057, 6025.548083893638, 5817.592768506164, 5846.503047241032, 5879.647221166743, 5902.527797776082, 6000.8799824004145, 6022.879542409215, 6084.178635884099, 6089.847753806191, 6090.390960903874, 6092.939070609237, 5843.678597676999, 5844.620099693507, 5846.35690074083, 5849.970750146222, 5851.21008663825, 5644.88710225785, 5769.74036168365, 5832.883342333214, 5852.707364631666, 5892.263467066617, 5822.94177058224, 5839.270091238595, 5842.883142337215, 5843.7370318336625, 5880.8235752927485, 5806.158107074535, 5811.0, 5813.447722466359, 5815.9709201453725, 5833.154192641959, 5537.750801213874, 5550.47270509301, 5625.915611265917, 5645.4072322405555, 5784.623999440023, 5744.741486633196, 5756.539476841926, 5777.7977770777825, 5780.075187969905, 5814.94185058144, 5551.583631227755, 5621.269234999588, 5621.662700237999, 5621.915671264853, 5628.774849005994], "value": 5433.650041976197, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2792795042221, 620.2556931681981, 642.8746394453082, 647.7085311609777, 650.6681592387881, 34246.31507369854, 34587.65412345876, 43717.12565748687, 44727.77636111815, 44820.551794482046, 42578.574214257846, 45603.0, 45617.0, 45617.7719111404, 45683.54316456834, 8301.875471867927, 8862.512561809099, 9026.638934442615, 9027.277817774595, 9037.728868133967, 8474.364422668294, 10747.871473495288, 11040.668779936615, 11046.613368532104, 11051.72370690735, 10842.349459032444, 10874.782504349947, 10906.34561926283, 10910.945445272802, 10914.890851091466, 10721.0, 10783.245172837904, 10783.460826958699, 10795.5681772729, 10796.67609971702, 10605.0, 10634.042936135786, 10656.20078494116, 10677.25259231854, 10682.839757403644, 41535.792321038505, 41772.582274177475, 41888.581114188775, 41943.79028104871, 41995.7900210497, 3740.6259374062647, 3746.044758586543, 3809.9238015239816, 3839.865604703822, 3867.9806600966817, 31214.53178202329, 31348.21629459259, 31512.527312090337, 31617.8419107903, 31773.52339714906, 4290.270653988799, 4348.717333373321, 4410.933835992462, 4423.270160423526, 4491.056878055612, 337109.99999999756, 337131.0, 337704.0, 338797.0, 340654.0, 59823.102653460235, 60092.699536502914, 60131.0, 60240.0, 60419.0, 39016.6098339013, 39751.40372894409, 40005.39991900124, 42244.1551168981, 42257.78871105625, 16372.181390930406, 16533.50399488017, 16542.172891355385, 16549.420770272984, 16551.75172372391, 11653.30080195191, 11671.12466564994, 11930.642080737593, 12271.325077120844, 12373.381330933418, 18883.62232755337, 19593.41549873457, 19760.308389206308, 19761.40715778529, 19845.0, 7000.649967501605, 7099.290070992963, 7188.2325304757, 7256.637168141572, 7294.708211671474, 946.6024269806697, 1028.6965345223177, 1038.566777846582, 1059.3485006720966, 1075.800976819291, 31320.0, 32771.1807204817, 32881.3423731524, 32960.0, 33553.16117097043, 1129.8757136714955, 1139.3562637110006, 1146.18620779246, 1192.284629222477, 1207.8309036734863, 13395.397207125703, 16557.58606034859, 18692.53268668267, 18756.343527976456, 19176.564527398055, 505227.0, 506028.0, 506810.0, 506917.0, 508973.0, 60551.394486054574, 61329.693351533846, 61445.38554614397, 61466.0, 61476.077858832155, 1294.7086905446388, 1360.1159246489663, 1380.9447622095204, 1407.3385508810843, 1426.600551845485, 27860.44279114447, 30267.394652107276, 30513.84743076359, 30781.69218307788, 30944.381112378076, 57905.0, 58836.117458239016, 58878.116828246755, 58910.41089589049, 58915.11627325508, 465798.0, 468224.0, 469115.0, 469162.0, 469944.0, 26882.59676104899, 27597.172084837486, 29211.7078829209, 29885.252868678457, 30310.54534181945, 47893.0, 47927.5207247923, 47937.5206247947, 48046.27930581114, 48229.75885120552, 40232.195356093296, 40558.39162412625, 40943.0, 41051.794741026104, 42275.57724422839, 41012.0, 41370.379444308965, 41981.79009104935, 42316.94207644834, 42339.670104930745, 40417.0, 40586.1882762349, 41069.1786164281, 41110.0, 41126.0, 34842.0, 37023.0, 37811.43282850814, 38056.0, 38079.428808568446, 26008.73991260063, 27894.44211115807, 28267.71732282651, 28316.716832831407, 28958.855205723838], "value": 20477.725216693532, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.3411974959813, 425.5552947170205, 434.6894114245548, 435.7124297963344, 436.7510519004167, 18609.25562977481, 19063.90468047658, 20207.19171233149, 20267.189312427505, 20341.796582034174, 19408.320708775194, 19836.107375168114, 19925.701114483294, 20415.183392664312, 20607.793922060773, 5554.0, 5833.270841144857, 5841.8831623367505, 5848.239728835246, 5855.970720146393, 5535.750891209885, 5633.6619802811965, 5729.598928075036, 5735.541156707453, 5740.0, 5758.078707406816, 5761.049426844586, 5770.538356931435, 5776.480116789488, 5784.537237021028, 5566.610337276372, 5720.456556627114, 5757.625754325997, 5770.509506691937, 5771.365149833536, 5176.611754118456, 5192.740362981874, 5196.870078248036, 5199.376074871039, 5199.844004679866, 24077.518449631083, 24255.87872060646, 24394.26817195487, 24410.267691969093, 24471.632925506132, 2490.663760392342, 2503.7856639529814, 2514.6228065790096, 2515.2705715342527, 2614.75159859813, 14387.136771793726, 14980.400783968627, 15103.773443398359, 15182.392704291815, 15334.309956052004, 1918.673825449663, 1984.3154111831395, 1997.2510308634262, 2045.1921491011117, 2045.795420457957, 81566.0, 82062.58968705178, 83173.16826831775, 83725.58137209337, 85890.14109858884, 9563.187129093965, 9965.750856228507, 10067.748306292255, 10644.89355106439, 10813.351198928089, 14540.982131250923, 14557.490487832874, 14621.195834229007, 14686.0, 14694.338754756061, 7777.533347999138, 7819.178986206366, 7988.480748751313, 8062.113167551564, 8103.068147163034, 7725.690972361155, 7736.690532378754, 7776.222377762178, 7934.682612695427, 7934.761957141295, 4435.179491794029, 4453.0, 4492.258777301774, 4495.123450927038, 4577.130345234395, 2100.579884023171, 2154.2137119951103, 2154.3106206013927, 2158.7409510858797, 2162.0, 963.8072385522923, 991.9603215871429, 1032.607609108549, 1036.6216331039116, 1052.7157667429751, 18860.811391886178, 18917.7162342565, 20152.89923550402, 20304.796952030585, 20594.588108237753, 981.9263555233243, 992.846108853129, 1009.7879445316419, 1030.3920686794827, 1075.2795626929976, 10635.52140153695, 11186.466052848396, 11209.21535492524, 11268.351937294728, 11302.43487825622, 445352.0, 450213.0, 463821.0, 465903.0, 468404.0, 91236.54381728181, 91536.0, 94336.52831735798, 95285.0, 99916.0, 1002.8395456726888, 1033.4625994482976, 1065.3820783945293, 1071.757932254935, 1084.511969613677, 17491.47525574235, 17811.376601818873, 17906.194221260335, 17964.0, 18476.630467390307, 40458.0, 40891.97770055773, 41280.58719412767, 41551.79224103981, 42129.78935105305, 56497.43502565086, 58315.70842145932, 58408.70795645995, 58508.122378165215, 58598.41401585929, 8931.285497160341, 9021.458712477272, 9084.636614535344, 9189.0, 9229.617802614455, 7581.029480673568, 11006.614768483065, 12735.426905789447, 14153.150810951376, 14203.28983550839, 11895.464704088165, 12096.274223546616, 12502.87497125017, 12683.0, 13099.607011789662, 11837.408129593314, 12105.878941210474, 12157.69605759863, 12400.255984640951, 12479.313637749648, 12077.779943329368, 12151.75696486083, 12294.20087694297, 12410.193337433038, 12600.0, 8850.690225842065, 9104.453732776055, 9172.31207659415, 9307.627694892128, 9606.807863842823, 9674.613015479303, 12056.939715301367, 12646.683832904251, 12659.746805064031, 12679.556215532411], "value": 9450.295073786812, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.396047719243, 1504.052446958416, 1529.9005564638298, 1694.9576260593483, 1824.8448881845043, 7478.887816682754, 8002.919970800291, 8282.751517454479, 8302.584870756453, 8529.829403411928, 8312.501249925008, 8341.45780524267, 8385.329173666107, 8386.790330241733, 8426.199511046441, 2395.5568219879333, 2432.4526981429212, 2435.8538487690707, 2446.1805295226122, 2452.6075827867544, 2374.25211058516, 2390.796782273509, 2470.5923522618837, 2481.4292712676097, 2482.354587807174, 2379.3218932604213, 2402.5435167318155, 2415.5048215115858, 2451.2156110044793, 2453.251758213744, 2296.3111066680094, 2310.306907927615, 2332.4052366646565, 2336.532693461306, 2337.4857531343077, 2337.836351455399, 2348.8708121053337, 2354.0348457132663, 2358.811295096388, 2367.538330025646, 8203.466774659688, 8295.0, 8469.49183049013, 8481.575921203977, 8494.915050849475, 5122.33409656746, 5339.225812257239, 5355.357357117171, 5358.3569971603265, 5363.54409875161, 3488.476728490721, 3610.0433385152955, 3618.131648404364, 3688.870889518854, 3689.096171438015, 1102.200904344352, 1106.8505751723494, 1122.1359553144034, 1148.5520646947698, 1153.0832987774738, 11471.369074700888, 11477.483513241925, 11564.074874010059, 11584.826227606593, 11588.188826782212, 4245.150969805989, 4528.139653465831, 4604.194266003436, 4608.631309495299, 4629.3518907353, 9269.814603708022, 9278.907210927804, 9285.675001375055, 9292.90707092934, 9294.488803115759, 5273.525382715574, 5277.23480095384, 5279.973600131974, 5281.735913204325, 5285.127953887565, 4388.188185185751, 4395.516493185747, 4840.2255639098275, 4875.366202393737, 4937.407511098691, 3803.82882770276, 3865.207632435344, 3944.9605503944595, 3958.188571342868, 3962.841486340572, 1219.3354621731178, 1220.2373516552154, 1229.9606832226755, 1230.6431134970758, 1239.6962744127748, 1002.4486532407146, 1013.3362647465922, 1030.5002073994256, 1035.2184101003695, 1048.7692707604315, 5773.624714393635, 5916.437938395846, 5971.58198926071, 6036.3058248302, 6193.040078787795, 923.676713150392, 939.4363381970763, 945.2768631996528, 988.604558176735, 997.9301448898652, 3714.2200137971327, 4034.293998550242, 4071.3892916062237, 4185.351270553069, 4247.171801498678, 9972.102510774064, 10100.292979491513, 10186.388816671024, 10341.74145646365, 10365.533550990223, 10279.794404111875, 10298.485075746332, 10298.691039268833, 10315.1747860171, 10316.0, 7522.134954480195, 7834.843303134019, 7894.802629934297, 7896.486728362638, 7902.249286317906, 5625.156226565884, 5648.096304591246, 5704.0, 5713.885722285614, 5783.94216057834, 9507.239420846454, 9571.664991725256, 9636.614535418785, 9682.709518714168, 9730.464824434725, 9206.953965230132, 9517.428954262767, 9526.237900967768, 9722.902770972483, 9723.46520941355, 6559.639219842955, 6726.529142959946, 7280.235575264521, 7520.210377910241, 7682.846343073219, 7853.842923141619, 8193.34453243751, 8204.548749818818, 8206.876896846672, 8210.3021243195, 7066.399356054793, 7222.819429514304, 7263.382612477787, 7282.817929551804, 7313.817154571178, 6992.930070699228, 7197.532160409557, 7267.091613548307, 7275.8181045472165, 7393.07586551681, 6683.799486015428, 6807.5575087619145, 6814.829629259309, 6816.182058153054, 6833.89749153773, 4838.0, 5068.898622027465, 5151.381834179772, 5156.458571850052, 5162.406323272871, 4804.807807687654, 4947.109520286383, 4956.504349565159, 5003.774075351562, 5063.265826455217], "value": 4545.4696110193245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.2599346421534, 340.40429248814576, 346.4941185868632, 357.7549378675607, 362.2411048852654, 5342.786288548458, 5354.22363757256, 5376.596755243362, 5401.378841433237, 5407.702576358299, 5060.41805192403, 5143.588512918966, 5182.352205974254, 5200.297959775429, 5300.144949267755, 4174.039970806716, 4176.791160441966, 4180.832766689329, 4197.2444959907125, 4197.328427451608, 4216.936745948813, 4217.536071032184, 4218.303979843322, 4232.280512312914, 4234.771916144315, 3973.960260397402, 3974.0, 4120.958790412087, 4155.563665815092, 4233.830646774125, 4135.958640413603, 4144.647704945083, 4151.543330233671, 4158.708890377675, 4161.875143745692, 3700.0009997300576, 3710.7588006779474, 3716.572594151653, 3716.832742526593, 3718.6839118674943, 5075.777599353667, 5185.662931909414, 5209.557187639055, 5218.112920803473, 5237.685738855681, 4741.525847415231, 4764.880877978044, 4769.332293478916, 4776.686411236903, 4780.235162374003, 5536.505143611243, 5549.500544950974, 5553.722313884289, 5565.5825813063775, 5570.442955704438, 3958.307296223178, 4064.288749468831, 4094.6282995196643, 4128.504579450485, 4131.938020929689, 5685.953056899513, 5704.600677952503, 5737.942620573783, 5743.282089738783, 5746.655200687972, 4143.1713657268665, 4147.274227010261, 4156.625903668684, 4192.769397683096, 4206.8527601534415, 4077.4699289092823, 4198.118395137056, 4231.280682284019, 4237.216115018731, 4247.193033323659, 4744.217204161344, 4756.262779269219, 4757.785899634525, 4768.61851051915, 4789.4971028042255, 5558.833235002957, 5559.054960656698, 5561.4716601922755, 5567.693776842231, 5581.358143813432, 1391.522462935039, 1442.4158215922569, 1443.444273954514, 1447.2835946206694, 1449.8840092792552, 1013.8732658417698, 1018.3279035836313, 1032.0762917189074, 1032.726327523207, 1034.984475232872, 5099.184130539096, 5158.613104017214, 5159.406668233201, 5166.61250406221, 5181.948180518147, 5470.53500452466, 5484.670919744828, 5486.231927530149, 5489.3531940417715, 5519.558435325164, 5103.438621751604, 5140.30605868203, 5143.894062776521, 5149.433562308143, 5181.611379146504, 2911.7088291171135, 2943.7203465670727, 2944.617199764017, 2948.3366242595243, 2977.243426378447, 5711.0, 5724.427557244242, 5729.455701708331, 5738.225339579187, 5764.550066221923, 5435.891282174334, 5542.39033706292, 5637.295338082739, 5675.829725108253, 5706.71466426677, 5592.664440133686, 5671.6597004179885, 5675.432456754292, 5685.005124103265, 5706.743196556165, 5303.496167864047, 5501.972490137684, 5556.277683901067, 5559.722013899208, 5579.442055794388, 5427.918581221364, 5441.020616289106, 5459.461350472049, 5462.235287059735, 5474.288342515448, 5534.335879694462, 5608.7380339424935, 5658.264425624807, 5672.829815105553, 5699.202111704281, 3982.26328129297, 4095.0720235032095, 4098.897527561835, 4104.610062044101, 4111.383292506148, 5484.396716361277, 5519.39286678473, 5596.524295434933, 5608.635438696471, 5610.747516361692, 5468.261784659179, 5487.862803429946, 5520.420355862577, 5624.775008999594, 5640.689762063126, 5495.642783219078, 5546.750396232099, 5592.3009623797025, 5605.831825045255, 5608.775648974159, 5532.806351777668, 5541.889162216652, 5565.805196818092, 5600.131979543177, 5605.187247848958, 5596.272484576979, 5620.0, 5640.971795140998, 5649.096144616841, 5652.0, 5242.68543887368, 5481.437790229766, 5497.3952865184, 5535.612507124462, 5548.528375088163], "value": 4237.50004079918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.1178673991759, 788.2235997542423, 789.3527307607764, 855.8844555984942, 870.7866572689692, 15031.398744050239, 15241.237938103106, 15979.121148336837, 16184.676306473893, 16249.350025998945, 13023.869761302383, 13940.442382304722, 14036.368363423644, 14042.08726432781, 14415.351309191085, 828.7472320942126, 838.8238469921293, 843.6667516331046, 845.9069502354736, 847.220557087481, 832.6086739232551, 835.0605568735173, 835.5446281776416, 835.8579041562919, 835.9289460395843, 877.9517126558037, 878.4597472554397, 878.8286284174557, 880.2429910277189, 880.6301353431542, 873.2839071960931, 873.9650413983433, 874.33113668044, 874.7463235661651, 874.8687696845492, 644.7614382678393, 645.2869579115057, 645.6255371884296, 646.205167643796, 646.6863571167979, 13046.412911418915, 13064.477420903153, 14236.501722439769, 14509.854901450955, 14658.0, 14180.361883715257, 14244.287785610679, 14526.636834079232, 14554.563363099123, 14958.775618365733, 11659.0, 12021.759564808655, 12024.759504809943, 12234.0, 12552.560660376934, 3762.454444105617, 3767.9811600942094, 3775.6035616260447, 3782.243551289753, 3812.504374431306, 64726.3527364725, 64767.352326476605, 64940.0, 65004.67497662482, 65819.0, 10522.0, 10793.40636265013, 10806.297590656583, 11025.724356890982, 11161.83257251142, 20745.27391541319, 20789.0, 20825.79174208269, 20829.68755468669, 20836.791632083787, 8473.322134229247, 8507.532085735344, 8531.146885311418, 8563.95718021406, 8573.74278771638, 4396.736195828261, 4664.3936288282985, 4771.5228477152705, 4898.24077268024, 4954.677945933575, 3538.380783362901, 3647.252313275772, 3647.9270414592092, 3649.9817500912327, 3656.067702735785, 551.4292707048266, 620.6772478311343, 627.5356236385043, 627.8367624417684, 629.351767679291, 703.3494018033299, 738.3834498194068, 747.5253214209016, 764.8317370178552, 800.855845947735, 9378.0, 9812.74306909415, 9855.950720246354, 10633.361998280128, 10639.840402393971, 705.2383425900016, 722.9313215244543, 729.6060127531074, 784.4576234206743, 785.6386062411354, 4671.883202919887, 4810.326554282403, 4855.295982082578, 4865.95134048662, 4949.232868905254, 51574.74212628988, 51980.0, 52470.0, 53275.73362133242, 56480.0, 71047.28952710406, 72903.27096728965, 73938.63030684812, 74601.62699186469, 75162.0, 67046.66476667585, 67386.32613673898, 67885.32114678889, 68086.0, 68857.999999999, 9778.119969202806, 10103.393796372242, 10189.184865210616, 10198.286119971532, 10279.743006424898, 44823.0, 45345.773271134756, 45446.77276613596, 45818.5569669228, 46678.0, 63280.68359658172, 64376.0, 64381.67809161112, 65713.0, 66800.6659966697, 12330.075244356529, 12496.500139994298, 12588.244705317711, 12640.494380224687, 12953.870461295266, 13878.89257941083, 14088.22514761657, 14116.576502704935, 14297.142171469744, 14425.918056145621, 13378.0, 13696.452141914211, 13866.930665346608, 14292.785608216092, 14561.126332420088, 13241.602751917459, 13261.933690331487, 13261.933690331487, 13911.304434778423, 14312.0, 13560.93219533896, 13638.249896255802, 14111.929440352733, 14403.495877644233, 14592.270386480846, 9899.554520046471, 9963.950180249052, 10344.120749736358, 10446.63436779709, 10537.0, 9802.970688077934, 10443.375270198781, 10889.618863339745, 10963.890361096286, 11056.834147487632], "value": 7231.4476301474015, "unit": "score"}], "name": "dromaeo_css", "value": 7260.443029002748, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 113.0, 113.0, 112.0, 114.0, 112.0, 113.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 128.0, 122.0, 161.0, 124.0, 130.0, 123.0, 121.0, 149.0, 125.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 109.0, 76.0, 76.0, 76.0, 75.0, 97.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 83.0, 83.0, 82.0, 98.0, 82.0, 82.0, 115.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 86.0, 84.0, 85.0, 84.0, 85.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 53.0, 50.0, 51.0, 51.0, 52.0, 51.0, 51.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 75.0, 76.0, 75.0, 75.0, 75.0, 79.0, 76.0, 74.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 137.0, 127.0, 139.0, 132.0, 122.0, 127.0, 133.0, 166.0, 126.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 156.0, 156.0, 154.0, 157.0, 158.0, 158.0, 157.0, 155.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 60.0, 60.0, 60.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1465.9, "alertThreshold": 2.0}]} 10:11:50 INFO - Return code: 0 10:11:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:50 ERROR - # TBPL SUCCESS # 10:11:50 INFO - Running post-action listener: _resource_record_post_action 10:11:50 INFO - [mozharness: 2016-11-21 18:11:50.417770Z] Finished run-tests step (success) 10:11:50 INFO - Running post-run listener: _resource_record_post_run 10:11:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 358600704; Read time: 176; Write time: 227868 10:11:50 INFO - TinderboxPrint: CPU usage
13.0% 10:11:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 10:11:50 INFO - TinderboxPrint: I/O write bytes / time
358,600,704 / 227,868 10:11:50 INFO - TinderboxPrint: CPU idle
8,261.0 (87.0%) 10:11:50 INFO - TinderboxPrint: CPU user
1,190.9 (12.5%) 10:11:50 INFO - TinderboxPrint: Swap in / out
0 / 0 10:11:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110301184; Read time: 0; Write time: 76436 10:11:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 247017472; Read time: 160; Write time: 151376 10:11:51 INFO - Running post-run listener: _upload_blobber_files 10:11:51 INFO - Blob upload gear active. 10:11:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:51 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 10:11:51 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'] 10:11:51 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 10:11:51 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:54 INFO - (blobuploader) - INFO - Done attempting. 10:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:55 INFO - (blobuploader) - INFO - Done attempting. 10:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:57 INFO - (blobuploader) - INFO - Done attempting. 10:11:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:57 INFO - Return code: 0 10:11:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e464fe2166d1a652a525d9e655525d6783527835869c7df77a9535c92fe64be7b18eb1cf8b1e9986747156c3b892463551b6c144e56c52e4f60014e5c3b82430", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b4c3b241494ecadf61a2be88bf348043c6339b6c5dee82b7872f6dcc506c3bcf4da4f42c8e178302635c6d5727aa3893a757f3c04d3c914db4bf7ea03631b79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf1b15a172df516dbc471fbe9cab55538c31f1dfc75a720917cddaac87080ca731662a656013af9c24942b9999dfc785bbbc0e4c7d759c4f334c2b7b57d902cd"} 10:11:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:57 INFO - Contents: 10:11:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e464fe2166d1a652a525d9e655525d6783527835869c7df77a9535c92fe64be7b18eb1cf8b1e9986747156c3b892463551b6c144e56c52e4f60014e5c3b82430", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b4c3b241494ecadf61a2be88bf348043c6339b6c5dee82b7872f6dcc506c3bcf4da4f42c8e178302635c6d5727aa3893a757f3c04d3c914db4bf7ea03631b79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf1b15a172df516dbc471fbe9cab55538c31f1dfc75a720917cddaac87080ca731662a656013af9c24942b9999dfc785bbbc0e4c7d759c4f334c2b7b57d902cd"} 10:11:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:57 INFO - Copying logs to upload dir... 10:11:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.741721 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-21 10:11:53.936241) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 10:11:53.939790) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999 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/e464fe2166d1a652a525d9e655525d6783527835869c7df77a9535c92fe64be7b18eb1cf8b1e9986747156c3b892463551b6c144e56c52e4f60014e5c3b82430", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b4c3b241494ecadf61a2be88bf348043c6339b6c5dee82b7872f6dcc506c3bcf4da4f42c8e178302635c6d5727aa3893a757f3c04d3c914db4bf7ea03631b79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf1b15a172df516dbc471fbe9cab55538c31f1dfc75a720917cddaac87080ca731662a656013af9c24942b9999dfc785bbbc0e4c7d759c4f334c2b7b57d902cd"} build_url:https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/GS5H9cTDQgq2KCY3u6Fm4Q/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/e464fe2166d1a652a525d9e655525d6783527835869c7df77a9535c92fe64be7b18eb1cf8b1e9986747156c3b892463551b6c144e56c52e4f60014e5c3b82430", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b4c3b241494ecadf61a2be88bf348043c6339b6c5dee82b7872f6dcc506c3bcf4da4f42c8e178302635c6d5727aa3893a757f3c04d3c914db4bf7ea03631b79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf1b15a172df516dbc471fbe9cab55538c31f1dfc75a720917cddaac87080ca731662a656013af9c24942b9999dfc785bbbc0e4c7d759c4f334c2b7b57d902cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 10:11:53.966718) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 10:11:53.967283) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1479750680.463354-1768703999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 10:11:54.050995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 10:11:54.051353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 10:11:54.051663) ========= ========= Total master_lag: 0.15 =========