builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1483666939.51 results: success (0) buildid: 20170105154014 builduid: b6ed06031b8c4cc1ab7d0402e07abd50 revision: 87a48d902eb2655d031216b91375097c6faf454e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:19.506132) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:19.506623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:19.506922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:19.521639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:19.521968) ========= 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=7de08804244eb36560b44971000001c3-1483666939.510170-472616284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 17:42:20-- 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% 65.7M=0s 2017-01-05 17:42:20 (65.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:19.612126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:19.612471) ========= 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=7de08804244eb36560b44971000001c3-1483666939.510170-472616284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014152 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:19.661945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 17:42:19.662256) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 87a48d902eb2655d031216b91375097c6faf454e --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 87a48d902eb2655d031216b91375097c6faf454e --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=7de08804244eb36560b44971000001c3-1483666939.510170-472616284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 17:42:20,353 truncating revision to first 12 chars 2017-01-05 17:42:20,353 Setting DEBUG logging. 2017-01-05 17:42:20,353 attempt 1/10 2017-01-05 17:42:20,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/87a48d902eb2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 17:42:21,628 unpacking tar archive at: mozilla-aurora-87a48d902eb2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.576823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 17:42:21.253589) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:21.254090) ========= script_repo_revision: 87a48d902eb2655d031216b91375097c6faf454e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:21.254705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:21.255135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 17:42:21.265589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-05 17:42:21.266003) ========= /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=7de08804244eb36560b44971000001c3-1483666939.510170-472616284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:42:22 INFO - MultiFileLogger online at 20170105 17:42:22 in /builds/slave/test 17:42:22 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 17:42:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:22 INFO - {'append_to_log': False, 17:42:22 INFO - 'base_work_dir': '/builds/slave/test', 17:42:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:42:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:22 INFO - 'branch': 'Mozilla-Aurora', 17:42:22 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:22 INFO - 'config_files': ('talos/linux_config.py',), 17:42:22 INFO - 'default_actions': ('clobber', 17:42:22 INFO - 'read-buildbot-config', 17:42:22 INFO - 'download-and-extract', 17:42:22 INFO - 'populate-webroot', 17:42:22 INFO - 'create-virtualenv', 17:42:22 INFO - 'install', 17:42:22 INFO - 'run-tests'), 17:42:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:22 INFO - 'download_minidump_stackwalk': True, 17:42:22 INFO - 'download_symbols': 'ondemand', 17:42:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:22 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:22 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:22 INFO - 'installer_path': 'installer.exe', 17:42:22 INFO - 'log_level': 'info', 17:42:22 INFO - 'log_name': 'talos', 17:42:22 INFO - 'log_to_console': True, 17:42:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:42:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:42:22 INFO - 'opt_config_files': (), 17:42:22 INFO - 'pip_index': False, 17:42:22 INFO - 'sps_profile': False, 17:42:22 INFO - 'sps_profile_interval': 0, 17:42:22 INFO - 'suite': 'dromaeojs', 17:42:22 INFO - 'system_bits': '32', 17:42:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:22 INFO - 'title': 'talos-linux64-ix-003', 17:42:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:22 INFO - 'use_talos_json': True, 17:42:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:22 INFO - 'work_dir': 'build'} 17:42:22 INFO - [mozharness: 2017-01-06 01:42:22.060580Z] Running clobber step. 17:42:22 INFO - Running pre-action listener: _resource_record_pre_action 17:42:22 INFO - Running main action method: clobber 17:42:22 INFO - rmtree: /builds/slave/test/build 17:42:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:23 INFO - Running post-action listener: _resource_record_post_action 17:42:23 INFO - [mozharness: 2017-01-06 01:42:23.119173Z] Finished clobber step (success) 17:42:23 INFO - [mozharness: 2017-01-06 01:42:23.119271Z] Running read-buildbot-config step. 17:42:23 INFO - Running pre-action listener: _resource_record_pre_action 17:42:23 INFO - Running main action method: read_buildbot_config 17:42:23 INFO - Using buildbot properties: 17:42:23 INFO - { 17:42:23 INFO - "project": "", 17:42:23 INFO - "product": "firefox", 17:42:23 INFO - "script_repo_revision": "production", 17:42:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:42:23 INFO - "repository": "", 17:42:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:42:23 INFO - "buildid": "20170105154014", 17:42:23 INFO - "pgo_build": "True", 17:42:23 INFO - "basedir": "/builds/slave/test", 17:42:23 INFO - "buildnumber": 996, 17:42:23 INFO - "slavename": "talos-linux64-ix-003", 17:42:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:42:23 INFO - "platform": "ubuntu64_hw", 17:42:23 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:42:23 INFO - "branch": "mozilla-aurora", 17:42:23 INFO - "repo_path": "releases/mozilla-aurora", 17:42:23 INFO - "revision": "87a48d902eb2655d031216b91375097c6faf454e", 17:42:23 INFO - "stage_platform": "linux64-pgo", 17:42:23 INFO - "builduid": "b6ed06031b8c4cc1ab7d0402e07abd50", 17:42:23 INFO - "slavebuilddir": "test" 17:42:23 INFO - } 17:42:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 17:42:23 INFO - Running post-action listener: _resource_record_post_action 17:42:23 INFO - [mozharness: 2017-01-06 01:42:23.121704Z] Finished read-buildbot-config step (success) 17:42:23 INFO - [mozharness: 2017-01-06 01:42:23.121791Z] Running download-and-extract step. 17:42:23 INFO - Running pre-action listener: _resource_record_pre_action 17:42:23 INFO - Running main action method: download_and_extract 17:42:23 INFO - mkdir: /builds/slave/test/build/tests 17:42: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')]} 17:42:23 INFO - trying https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 17:42:23 INFO - Downloading https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/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 17:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/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 17:42:23 INFO - Downloaded 1361 bytes. 17:42:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 17:42:23 INFO - Using the following test package requirements: 17:42:23 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 17:42:23 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:42:23 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:42:23 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:42:23 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:42:23 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:42:23 INFO - u'jsshell-linux-x86_64.zip'], 17:42:23 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:42:23 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:42:23 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 17:42:23 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:42:23 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:42:23 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:42:23 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:42:23 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:42:23 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:42:23 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 17:42:23 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:42:23 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:42:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 17:42:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:42:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:42:24 INFO - Http code: 200 17:42:24 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 17:42:24 INFO - x-amz-cf-id: 9GB0wRTOdVU56_7A6Bu_Ror17ag8i6marj8mpipmb_RNahrLQOyvRw== 17:42:24 INFO - x-amz-version-id: PlSkVSkSbE9P4c4hBDSo_FehQCB2Y7lp 17:42:24 INFO - Expected file size: 21942775 17:42:24 INFO - Obtained file size: 21942775 17:42:28 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 17:42:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 17:42:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:42:28 INFO - Fetch https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:42:29 INFO - Http code: 200 17:42:29 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 17:42:29 INFO - x-amz-cf-id: yvfo-h3l1f3q4t6nBZNvzfDkyro6k7Nd1a3YhmlAUWLsmzeqB_hOxg== 17:42:29 INFO - x-amz-version-id: PlSkVSkSbE9P4c4hBDSo_FehQCB2Y7lp 17:42:29 INFO - Expected file size: 21942775 17:42:29 INFO - Obtained file size: 21942775 17:42:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 17:42:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:42:34 INFO - Fetch https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 17:42:35 INFO - Http code: 200 17:42:35 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 17:42:35 INFO - x-amz-cf-id: LLqUYMth9j1cR4YF-ztAwFKYz_VZXDWOt0wk3SVQ932faB8g0zvY1g== 17:42:35 INFO - x-amz-version-id: xrUQf9rY5W5Nv9sRt83pYejPI83OXxkI 17:42:35 INFO - Expected file size: 14409038 17:42:35 INFO - Obtained file size: 14409038 17:42: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')]} 17:42:35 INFO - trying https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 17:42:35 INFO - Downloading https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/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 17:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/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 17:42:36 INFO - Downloaded 64080762 bytes. 17:42:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 17:42:36 INFO - mkdir: /builds/slave/test/properties 17:42:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:36 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:36 INFO - Contents: 17:42:36 INFO - build_url:https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 17:42:37 INFO - Running post-action listener: _resource_record_post_action 17:42:37 INFO - Running post-action listener: set_extra_try_arguments 17:42:37 INFO - [mozharness: 2017-01-06 01:42:37.312261Z] Finished download-and-extract step (success) 17:42:37 INFO - [mozharness: 2017-01-06 01:42:37.312527Z] Running populate-webroot step. 17:42:37 INFO - Running pre-action listener: _resource_record_pre_action 17:42:37 INFO - Running main action method: populate_webroot 17:42:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:42:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:42:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:42:37 INFO - '--tppagecycles', 17:42:37 INFO - '7'], 17:42:37 INFO - 'tests': ['tsvgm']}}, 17:42:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:42:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:42:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:42:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:42:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:37 INFO - 'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:37 INFO - 'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['damp', 'tps']}, 17:42:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:37 INFO - 'tests': ['damp', 'tps']}, 17:42:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['dromaeo_dom']}, 17:42:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['basic_compositor_video']}, 17:42:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:42:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['a11yr', 17:42:37 INFO - 'ts_paint', 17:42:37 INFO - 'tpaint', 17:42:37 INFO - 'sessionrestore', 17:42:37 INFO - 'sessionrestore_no_auto_restore', 17:42:37 INFO - 'tabpaint']}, 17:42:37 INFO - 'other-e10s': {'tests': ['a11yr', 17:42:37 INFO - 'ts_paint', 17:42:37 INFO - 'tpaint', 17:42:37 INFO - 'sessionrestore', 17:42:37 INFO - 'sessionrestore_no_auto_restore', 17:42:37 INFO - 'tabpaint']}, 17:42:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:42:37 INFO - 'ts_paint', 17:42:37 INFO - 'tpaint', 17:42:37 INFO - 'sessionrestore', 17:42:37 INFO - 'sessionrestore_no_auto_restore', 17:42:37 INFO - 'tabpaint']}, 17:42:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:42:37 INFO - 'ts_paint', 17:42:37 INFO - 'tpaint', 17:42:37 INFO - 'sessionrestore', 17:42:37 INFO - 'sessionrestore_no_auto_restore', 17:42:37 INFO - 'tabpaint']}, 17:42:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['a11yr', 17:42:37 INFO - 'ts_paint', 17:42:37 INFO - 'tpaint', 17:42:37 INFO - 'sessionrestore', 17:42:37 INFO - 'sessionrestore_no_auto_restore', 17:42:37 INFO - 'tabpaint']}, 17:42:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['a11yr', 17:42:37 INFO - 'ts_paint', 17:42:37 INFO - 'tpaint', 17:42:37 INFO - 'sessionrestore', 17:42:37 INFO - 'sessionrestore_no_auto_restore', 17:42:37 INFO - 'tabpaint']}, 17:42:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['tsvgx', 17:42:37 INFO - 'tsvgr_opacity', 17:42:37 INFO - 'tart', 17:42:37 INFO - 'tscrollx', 17:42:37 INFO - 'cart']}, 17:42:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:42:37 INFO - 'tsvgr_opacity', 17:42:37 INFO - 'tart', 17:42:37 INFO - 'tscrollx', 17:42:37 INFO - 'cart']}, 17:42:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:37 INFO - 'talos_options': ['--disable-e10s'], 17:42:37 INFO - 'tests': ['tp5o']}, 17:42:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:37 INFO - 'tests': ['tp5o']}, 17:42:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:37 INFO - 'talos_options': ['--disable-e10s', 17:42:37 INFO - '--xperf_path', 17:42:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:37 INFO - 'tests': ['tp5n']}, 17:42:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:42:37 INFO - 'talos_options': ['--xperf_path', 17:42:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:37 INFO - 'tests': ['tp5n']}}, 17:42:37 INFO - 'talos.zip': {'path': '', 17:42:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:42:37 INFO - Running post-action listener: _resource_record_post_action 17:42:37 INFO - [mozharness: 2017-01-06 01:42:37.330808Z] Finished populate-webroot step (success) 17:42:37 INFO - [mozharness: 2017-01-06 01:42:37.330896Z] Running create-virtualenv step. 17:42:37 INFO - Running pre-action listener: _resource_record_pre_action 17:42:37 INFO - Running main action method: create_virtualenv 17:42:37 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42: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 17:42:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:42:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:37 INFO - Using real prefix '/usr' 17:42:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:37 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:39 INFO - Installing pip.................done. 17:42:39 INFO - Return code: 0 17:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:42:40 INFO - Reading from file tmpfile_stdout 17:42:40 INFO - Output received: 17:42: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) 17:42:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42: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 17:42: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 17:42:40 INFO - Using env: {'DISPLAY': ':0', 17:42:40 INFO - 'HOME': '/home/cltbld', 17:42:40 INFO - 'LANG': 'en_US.UTF-8', 17:42:40 INFO - 'LANGUAGE': 'en_US:en', 17:42:40 INFO - 'LOGNAME': 'cltbld', 17:42:40 INFO - 'MAIL': '/var/mail/cltbld', 17:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:40 INFO - 'MOZ_NO_REMOTE': '1', 17:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:40 INFO - 'NO_EM_RESTART': '1', 17:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:40 INFO - 'PWD': '/builds/slave/test', 17:42:40 INFO - 'SHELL': '/bin/bash', 17:42:40 INFO - 'SHLVL': '1', 17:42:40 INFO - 'TERM': 'linux', 17:42:40 INFO - 'TMOUT': '86400', 17:42:40 INFO - 'USER': 'cltbld', 17:42:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:40 INFO - '_': '/tools/buildbot/bin/python'} 17:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42: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 17:42:40 INFO - Cleaning up... 17:42:40 INFO - Return code: 0 17:42:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42: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 17:42: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 17:42:40 INFO - Using env: {'DISPLAY': ':0', 17:42:40 INFO - 'HOME': '/home/cltbld', 17:42:40 INFO - 'LANG': 'en_US.UTF-8', 17:42:40 INFO - 'LANGUAGE': 'en_US:en', 17:42:40 INFO - 'LOGNAME': 'cltbld', 17:42:40 INFO - 'MAIL': '/var/mail/cltbld', 17:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:40 INFO - 'MOZ_NO_REMOTE': '1', 17:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:40 INFO - 'NO_EM_RESTART': '1', 17:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:40 INFO - 'PWD': '/builds/slave/test', 17:42:40 INFO - 'SHELL': '/bin/bash', 17:42:40 INFO - 'SHLVL': '1', 17:42:40 INFO - 'TERM': 'linux', 17:42:40 INFO - 'TMOUT': '86400', 17:42:40 INFO - 'USER': 'cltbld', 17:42:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:40 INFO - '_': '/tools/buildbot/bin/python'} 17:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:40 INFO - Downloading/unpacking psutil>=3.1.1 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:42 INFO - Installing collected packages: psutil 17:42:42 INFO - Running setup.py install for psutil 17:42:42 INFO - building 'psutil._psutil_linux' extension 17:42: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 17:42: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 17:42:42 INFO - building 'psutil._psutil_posix' extension 17:42: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 17:42:43 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 17:42:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:43 INFO - Successfully installed psutil 17:42:43 INFO - Cleaning up... 17:42:43 INFO - Return code: 0 17:42:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42: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 17:42: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 17:42:43 INFO - Using env: {'DISPLAY': ':0', 17:42:43 INFO - 'HOME': '/home/cltbld', 17:42:43 INFO - 'LANG': 'en_US.UTF-8', 17:42:43 INFO - 'LANGUAGE': 'en_US:en', 17:42:43 INFO - 'LOGNAME': 'cltbld', 17:42:43 INFO - 'MAIL': '/var/mail/cltbld', 17:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:43 INFO - 'MOZ_NO_REMOTE': '1', 17:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:43 INFO - 'NO_EM_RESTART': '1', 17:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:43 INFO - 'PWD': '/builds/slave/test', 17:42:43 INFO - 'SHELL': '/bin/bash', 17:42:43 INFO - 'SHLVL': '1', 17:42:43 INFO - 'TERM': 'linux', 17:42:43 INFO - 'TMOUT': '86400', 17:42:43 INFO - 'USER': 'cltbld', 17:42:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:43 INFO - '_': '/tools/buildbot/bin/python'} 17:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:42:45 INFO - Installing collected packages: mozsystemmonitor 17:42:45 INFO - Running setup.py install for mozsystemmonitor 17:42:45 INFO - Successfully installed mozsystemmonitor 17:42:45 INFO - Cleaning up... 17:42:45 INFO - Return code: 0 17:42:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42: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 17:42: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 17:42:45 INFO - Using env: {'DISPLAY': ':0', 17:42:45 INFO - 'HOME': '/home/cltbld', 17:42:45 INFO - 'LANG': 'en_US.UTF-8', 17:42:45 INFO - 'LANGUAGE': 'en_US:en', 17:42:45 INFO - 'LOGNAME': 'cltbld', 17:42:45 INFO - 'MAIL': '/var/mail/cltbld', 17:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:45 INFO - 'MOZ_NO_REMOTE': '1', 17:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:45 INFO - 'NO_EM_RESTART': '1', 17:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:45 INFO - 'PWD': '/builds/slave/test', 17:42:45 INFO - 'SHELL': '/bin/bash', 17:42:45 INFO - 'SHLVL': '1', 17:42:45 INFO - 'TERM': 'linux', 17:42:45 INFO - 'TMOUT': '86400', 17:42:45 INFO - 'USER': 'cltbld', 17:42:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:45 INFO - '_': '/tools/buildbot/bin/python'} 17:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:45 INFO - Downloading/unpacking jsonschema==2.5.1 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:48 INFO - warning: no files found matching '*.txt' 17:42:48 INFO - no previously-included directories found matching 'build' 17:42:48 INFO - no previously-included directories found matching 'dist' 17:42:48 INFO - no previously-included directories found matching '.git*' 17:42:48 INFO - Installing collected packages: jsonschema, functools32 17:42:48 INFO - Running setup.py install for functools32 17:42:48 INFO - warning: no files found matching '*.txt' 17:42:48 INFO - no previously-included directories found matching 'build' 17:42:48 INFO - no previously-included directories found matching 'dist' 17:42:48 INFO - no previously-included directories found matching '.git*' 17:42:48 INFO - Successfully installed jsonschema functools32 17:42:48 INFO - Cleaning up... 17:42:48 INFO - Return code: 0 17:42:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42: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 17:42: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 17:42:48 INFO - Using env: {'DISPLAY': ':0', 17:42:48 INFO - 'HOME': '/home/cltbld', 17:42:48 INFO - 'LANG': 'en_US.UTF-8', 17:42:48 INFO - 'LANGUAGE': 'en_US:en', 17:42:48 INFO - 'LOGNAME': 'cltbld', 17:42:48 INFO - 'MAIL': '/var/mail/cltbld', 17:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:48 INFO - 'MOZ_NO_REMOTE': '1', 17:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:48 INFO - 'NO_EM_RESTART': '1', 17:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:48 INFO - 'PWD': '/builds/slave/test', 17:42:48 INFO - 'SHELL': '/bin/bash', 17:42:48 INFO - 'SHLVL': '1', 17:42:48 INFO - 'TERM': 'linux', 17:42:48 INFO - 'TMOUT': '86400', 17:42:48 INFO - 'USER': 'cltbld', 17:42:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:48 INFO - '_': '/tools/buildbot/bin/python'} 17:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:42:48 INFO - Cleaning up... 17:42:48 INFO - Return code: 0 17:42:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42: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 17:42: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 17:42:48 INFO - Using env: {'DISPLAY': ':0', 17:42:48 INFO - 'HOME': '/home/cltbld', 17:42:48 INFO - 'LANG': 'en_US.UTF-8', 17:42:48 INFO - 'LANGUAGE': 'en_US:en', 17:42:48 INFO - 'LOGNAME': 'cltbld', 17:42:48 INFO - 'MAIL': '/var/mail/cltbld', 17:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:48 INFO - 'MOZ_NO_REMOTE': '1', 17:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:48 INFO - 'NO_EM_RESTART': '1', 17:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:48 INFO - 'PWD': '/builds/slave/test', 17:42:48 INFO - 'SHELL': '/bin/bash', 17:42:48 INFO - 'SHLVL': '1', 17:42:48 INFO - 'TERM': 'linux', 17:42:48 INFO - 'TMOUT': '86400', 17:42:48 INFO - 'USER': 'cltbld', 17:42:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:48 INFO - '_': '/tools/buildbot/bin/python'} 17:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:48 INFO - Downloading/unpacking blobuploader==1.2.4 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:51 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 17:42:51 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 17:42:51 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 17:42:51 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 17:42:51 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 17:42:51 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 17:42:51 INFO - Downloading docopt-0.6.1.tar.gz 17:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:51 INFO - Running setup.py install for blobuploader 17:42:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:51 INFO - Running setup.py install for requests 17:42:52 INFO - Running setup.py install for docopt 17:42:52 INFO - Successfully installed blobuploader requests docopt 17:42:52 INFO - Cleaning up... 17:42:52 INFO - Return code: 0 17:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:52 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')]} 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:52 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')]} 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:52 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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42:52 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 17:42:52 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 17:42:52 INFO - Using env: {'DISPLAY': ':0', 17:42:52 INFO - 'HOME': '/home/cltbld', 17:42:52 INFO - 'LANG': 'en_US.UTF-8', 17:42:52 INFO - 'LANGUAGE': 'en_US:en', 17:42:52 INFO - 'LOGNAME': 'cltbld', 17:42:52 INFO - 'MAIL': '/var/mail/cltbld', 17:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:52 INFO - 'MOZ_NO_REMOTE': '1', 17:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:52 INFO - 'NO_EM_RESTART': '1', 17:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:52 INFO - 'PWD': '/builds/slave/test', 17:42:52 INFO - 'SHELL': '/bin/bash', 17:42:52 INFO - 'SHLVL': '1', 17:42:52 INFO - 'TERM': 'linux', 17:42:52 INFO - 'TMOUT': '86400', 17:42:52 INFO - 'USER': 'cltbld', 17:42:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:52 INFO - '_': '/tools/buildbot/bin/python'} 17:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:52 INFO - Running setup.py (path:/tmp/pip-pyLByE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:52 INFO - Running setup.py (path:/tmp/pip-M9jANm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:52 INFO - Running setup.py (path:/tmp/pip-d96M2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:52 INFO - Running setup.py (path:/tmp/pip-nmL6mK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:52 INFO - Running setup.py (path:/tmp/pip-fDO6Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:52 INFO - Running setup.py (path:/tmp/pip-ZonL4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:52 INFO - Running setup.py (path:/tmp/pip-qeyyuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:52 INFO - Running setup.py (path:/tmp/pip-bFFB_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:53 INFO - Running setup.py (path:/tmp/pip-PtBZ4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:53 INFO - Running setup.py (path:/tmp/pip-Q09Ug2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:53 INFO - Running setup.py (path:/tmp/pip-ZmEjSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:53 INFO - Running setup.py (path:/tmp/pip-XS_m_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:53 INFO - Running setup.py (path:/tmp/pip-ZYU3nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:53 INFO - Running setup.py (path:/tmp/pip-nELw1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:53 INFO - Running setup.py (path:/tmp/pip-VrVAPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:53 INFO - Running setup.py (path:/tmp/pip-dkNauX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:53 INFO - Running setup.py (path:/tmp/pip-g03DmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:42:53 INFO - Running setup.py install for manifestparser 17:42:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:42:53 INFO - Running setup.py install for mozcrash 17:42:53 INFO - Running setup.py install for mozdebug 17:42:53 INFO - Running setup.py install for mozdevice 17:42:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Running setup.py install for mozfile 17:42:54 INFO - Running setup.py install for mozhttpd 17:42:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Running setup.py install for mozinfo 17:42:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Running setup.py install for mozInstall 17:42:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Running setup.py install for mozleak 17:42:54 INFO - Running setup.py install for mozlog 17:42:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Running setup.py install for moznetwork 17:42:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:42:54 INFO - Running setup.py install for mozprocess 17:42:54 INFO - Running setup.py install for mozprofile 17:42:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:42:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:42:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:42:55 INFO - Running setup.py install for mozrunner 17:42:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:42:55 INFO - Running setup.py install for mozscreenshot 17:42:55 INFO - Running setup.py install for moztest 17:42:55 INFO - Running setup.py install for mozversion 17:42:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:42:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:42:55 INFO - Cleaning up... 17:42:55 INFO - Return code: 0 17:42:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42: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 17:42: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 17:42:55 INFO - Using env: {'DISPLAY': ':0', 17:42:55 INFO - 'HOME': '/home/cltbld', 17:42:55 INFO - 'LANG': 'en_US.UTF-8', 17:42:55 INFO - 'LANGUAGE': 'en_US:en', 17:42:55 INFO - 'LOGNAME': 'cltbld', 17:42:55 INFO - 'MAIL': '/var/mail/cltbld', 17:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:55 INFO - 'MOZ_NO_REMOTE': '1', 17:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:55 INFO - 'NO_EM_RESTART': '1', 17:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:55 INFO - 'PWD': '/builds/slave/test', 17:42:55 INFO - 'SHELL': '/bin/bash', 17:42:55 INFO - 'SHLVL': '1', 17:42:55 INFO - 'TERM': 'linux', 17:42:55 INFO - 'TMOUT': '86400', 17:42:55 INFO - 'USER': 'cltbld', 17:42:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:55 INFO - '_': '/tools/buildbot/bin/python'} 17:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:55 INFO - Running setup.py (path:/tmp/pip-XQzSeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42: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)) 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:55 INFO - Running setup.py (path:/tmp/pip-Wptswv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42: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)) 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:55 INFO - Running setup.py (path:/tmp/pip-_xEIIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42: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)) 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:55 INFO - Running setup.py (path:/tmp/pip-i47jeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:56 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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:56 INFO - Running setup.py (path:/tmp/pip-VIpi_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:56 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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:56 INFO - Running setup.py (path:/tmp/pip-Bpg_Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:56 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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:56 INFO - Running setup.py (path:/tmp/pip-P1VkMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:56 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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:56 INFO - Running setup.py (path:/tmp/pip-ydOFos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:56 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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:56 INFO - Running setup.py (path:/tmp/pip-RAbkkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42: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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:56 INFO - Running setup.py (path:/tmp/pip-xAslh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42: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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:56 INFO - Running setup.py (path:/tmp/pip-l7zPVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42: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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:56 INFO - Running setup.py (path:/tmp/pip-5BgAKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42: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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:56 INFO - Running setup.py (path:/tmp/pip-_czWgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42: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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:56 INFO - Running setup.py (path:/tmp/pip-53_mpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42: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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:56 INFO - Running setup.py (path:/tmp/pip-D_oV2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42: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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:56 INFO - Running setup.py (path:/tmp/pip-bIIRKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:56 INFO - Running setup.py (path:/tmp/pip-deH_C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:58 INFO - Downloading blessings-1.6.tar.gz 17:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:42:59 INFO - Installing collected packages: blessings 17:42:59 INFO - Running setup.py install for blessings 17:42:59 INFO - Successfully installed blessings 17:42:59 INFO - Cleaning up... 17:42:59 INFO - Return code: 0 17:42:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:59 INFO - Reading from file tmpfile_stdout 17:42:59 INFO - Current package versions: 17:42:59 INFO - argparse == 1.2.1 17:42:59 INFO - blessings == 1.6 17:42:59 INFO - blobuploader == 1.2.4 17:42:59 INFO - docopt == 0.6.1 17:42:59 INFO - functools32 == 3.2.3-2 17:42:59 INFO - jsonschema == 2.5.1 17:42:59 INFO - manifestparser == 1.1 17:42:59 INFO - mozInstall == 1.12 17:42:59 INFO - mozcrash == 1.0 17:42:59 INFO - mozdebug == 0.1 17:42:59 INFO - mozdevice == 0.48 17:42:59 INFO - mozfile == 1.2 17:42:59 INFO - mozhttpd == 0.7 17:42:59 INFO - mozinfo == 0.9 17:42:59 INFO - mozleak == 0.1 17:42:59 INFO - mozlog == 3.4 17:42:59 INFO - moznetwork == 0.27 17:42:59 INFO - mozprocess == 0.23 17:42:59 INFO - mozprofile == 0.28 17:42:59 INFO - mozrunner == 6.13 17:42:59 INFO - mozscreenshot == 0.1 17:42:59 INFO - mozsystemmonitor == 0.3 17:42:59 INFO - moztest == 0.8 17:42:59 INFO - mozversion == 1.4 17:42:59 INFO - psutil == 3.1.1 17:42:59 INFO - requests == 1.2.3 17:42:59 INFO - wsgiref == 0.1.2 17:42:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42: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 17:42: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 17:42:59 INFO - Using env: {'DISPLAY': ':0', 17:42:59 INFO - 'HOME': '/home/cltbld', 17:42:59 INFO - 'LANG': 'en_US.UTF-8', 17:42:59 INFO - 'LANGUAGE': 'en_US:en', 17:42:59 INFO - 'LOGNAME': 'cltbld', 17:42:59 INFO - 'MAIL': '/var/mail/cltbld', 17:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:59 INFO - 'MOZ_NO_REMOTE': '1', 17:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:59 INFO - 'NO_EM_RESTART': '1', 17:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:59 INFO - 'PWD': '/builds/slave/test', 17:42:59 INFO - 'SHELL': '/bin/bash', 17:42:59 INFO - 'SHLVL': '1', 17:42:59 INFO - 'TERM': 'linux', 17:42:59 INFO - 'TMOUT': '86400', 17:42:59 INFO - 'USER': 'cltbld', 17:42:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:59 INFO - '_': '/tools/buildbot/bin/python'} 17:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42: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)) 17:42:59 INFO - Cleaning up... 17:42:59 INFO - Return code: 0 17:42:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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 0x7f80625dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1595ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, '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': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', '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 17:42: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 17:42: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 17:42:59 INFO - Using env: {'DISPLAY': ':0', 17:42:59 INFO - 'HOME': '/home/cltbld', 17:42:59 INFO - 'LANG': 'en_US.UTF-8', 17:42:59 INFO - 'LANGUAGE': 'en_US:en', 17:42:59 INFO - 'LOGNAME': 'cltbld', 17:42:59 INFO - 'MAIL': '/var/mail/cltbld', 17:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:59 INFO - 'MOZ_NO_REMOTE': '1', 17:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:59 INFO - 'NO_EM_RESTART': '1', 17:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:59 INFO - 'PWD': '/builds/slave/test', 17:42:59 INFO - 'SHELL': '/bin/bash', 17:42:59 INFO - 'SHLVL': '1', 17:42:59 INFO - 'TERM': 'linux', 17:42:59 INFO - 'TMOUT': '86400', 17:42:59 INFO - 'USER': 'cltbld', 17:42:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:59 INFO - '_': '/tools/buildbot/bin/python'} 17:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:42:59 INFO - Cleaning up... 17:42:59 INFO - Return code: 0 17:42:59 INFO - Running post-action listener: _resource_record_post_action 17:42:59 INFO - Running post-action listener: _start_resource_monitoring 17:42:59 INFO - Starting resource monitoring. 17:42:59 INFO - [mozharness: 2017-01-06 01:42:59.954530Z] Finished create-virtualenv step (success) 17:42:59 INFO - [mozharness: 2017-01-06 01:42:59.955025Z] Running install step. 17:42:59 INFO - Running pre-action listener: _resource_record_pre_action 17:42:59 INFO - Running main action method: install 17:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:00 INFO - Reading from file tmpfile_stdout 17:43:00 INFO - Detecting whether we're running mozinstall >=1.0... 17:43:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:43:00 INFO - Reading from file tmpfile_stdout 17:43:00 INFO - Output received: 17:43:00 INFO - Usage: mozinstall [options] installer 17:43:00 INFO - Options: 17:43:00 INFO - -h, --help show this help message and exit 17:43:00 INFO - -d DEST, --destination=DEST 17:43:00 INFO - Directory to install application into. [default: 17:43:00 INFO - "/builds/slave/test"] 17:43:00 INFO - --app=APP Application being installed. [default: firefox] 17:43:00 INFO - mkdir: /builds/slave/test/build/application 17:43:00 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'] 17:43:00 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 17:43:16 INFO - Reading from file tmpfile_stdout 17:43:16 INFO - Output received: 17:43:16 INFO - /builds/slave/test/build/application/firefox/firefox 17:43:16 INFO - Running post-action listener: _resource_record_post_action 17:43:16 INFO - [mozharness: 2017-01-06 01:43:16.352102Z] Finished install step (success) 17:43:16 INFO - [mozharness: 2017-01-06 01:43:16.352420Z] Running run-tests step. 17:43:16 INFO - Running pre-action listener: _resource_record_pre_action 17:43:16 INFO - Running main action method: run_tests 17:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:43:16 INFO - Python 2.7.3 17:43:16 INFO - Return code: 0 17:43:16 INFO - grabbing minidump binary from tooltool 17:43:16 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')]} 17:43:16 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 0x1592f60>, '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 0x1593d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15941d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:43:16 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 17:43:16 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 17:43:16 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 17:43:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:43:16 INFO - Return code: 0 17:43:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:43:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:43:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:43:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:43:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:43:16 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/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 17:43:16 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/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 17:43:16 INFO - Using env: {'DISPLAY': ':0', 17:43:16 INFO - 'HOME': '/home/cltbld', 17:43:16 INFO - 'LANG': 'en_US.UTF-8', 17:43:16 INFO - 'LANGUAGE': 'en_US:en', 17:43:16 INFO - 'LOGNAME': 'cltbld', 17:43:16 INFO - 'MAIL': '/var/mail/cltbld', 17:43:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:16 INFO - 'MOZ_NO_REMOTE': '1', 17:43:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:16 INFO - 'NO_EM_RESTART': '1', 17:43:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:16 INFO - 'PWD': '/builds/slave/test', 17:43:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:16 INFO - 'SHELL': '/bin/bash', 17:43:16 INFO - 'SHLVL': '1', 17:43:16 INFO - 'TERM': 'linux', 17:43:16 INFO - 'TMOUT': '86400', 17:43:16 INFO - 'USER': 'cltbld', 17:43:16 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1483666939.510170-472616284', 17:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:16 INFO - '_': '/tools/buildbot/bin/python'} 17:43:16 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/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 17:43:16 INFO - mozversion application_buildid: 20170105154014 17:43:16 INFO - mozversion application_changeset: 87a48d902eb2655d031216b91375097c6faf454e 17:43:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:43:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:43:16 INFO - mozversion application_name: Firefox 17:43:16 INFO - mozversion application_remotingname: firefox-dev 17:43:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:43:16 INFO - mozversion application_vendor: Mozilla 17:43:16 INFO - mozversion application_version: 52.0a2 17:43:16 INFO - mozversion platform_buildid: 20170105154014 17:43:16 INFO - mozversion platform_changeset: 87a48d902eb2655d031216b91375097c6faf454e 17:43:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:43:16 INFO - mozversion platform_version: 52.0a2 17:43:16 INFO - using testdate: 1483666996 17:43:16 INFO - actual date: 1483666996 17:43:16 INFO - starting webserver on 'localhost:45634' 17:43:16 INFO - SUITE-START | Running 2 tests 17:43:16 INFO - TEST-START | dromaeo_css 17:43:16 INFO - operating with platform_type : linux_ 17:43:16 INFO - Initialising browser for dromaeo_css test... 17:43:16 INFO - TEST-INFO | started process 13214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPnEBW/profile http://localhost:45634/getInfo.html) 17:43:20 INFO - PROCESS | 13214 | __metrics Screen width/height:1600/1200 17:43:20 INFO - PROCESS | 13214 | colorDepth:24 17:43:20 INFO - PROCESS | 13214 | Browser inner width/height: 1024/697 17:43:20 INFO - PROCESS | 13214 | __metrics 17:43:21 INFO - PROCESS | 13214 | 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" 17:43:21 INFO - PROCESS | 13214 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:43:22 INFO - PROCESS | 13214 | console.error: PushService: 17:43:22 INFO - PROCESS | 13214 | stateChangeProcessEnqueue: Error transitioning state 17:43:22 INFO - PROCESS | 13214 | UnknownError 17:43:22 INFO - TEST-INFO | 13214: exit 0 17:43:22 INFO - Browser initialized. 17:43:22 INFO - Running cycle 1/1 for dromaeo_css test... 17:43:22 INFO - TEST-INFO | started process 13308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPnEBW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:34 INFO - PROCESS | 13308 | RSS: Main: 148152320 17:43:34 INFO - PROCESS | 13308 | 17:46:35 INFO - PROCESS | 13308 | Cycle 1(1): loaded http://localhost:45634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45634/tests/dromaeo/cssquery-ext.html) 17:46:37 INFO - PROCESS | 13308 | RSS: Main: 300269568 17:46:37 INFO - PROCESS | 13308 | 17:49:39 INFO - PROCESS | 13308 | Cycle 1(1): loaded http://localhost:45634/tests/dromaeo/cssquery-ext.html (next: http://localhost:45634/tests/dromaeo/cssquery-jquery.html) 17:49:40 INFO - PROCESS | 13308 | RSS: Main: 232452096 17:49:40 INFO - PROCESS | 13308 | 17:52:42 INFO - PROCESS | 13308 | Cycle 1(1): loaded http://localhost:45634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45634/tests/dromaeo/cssquery-mootools.html) 17:52:43 INFO - PROCESS | 13308 | RSS: Main: 203862016 17:52:43 INFO - PROCESS | 13308 | 17:55:45 INFO - PROCESS | 13308 | Cycle 1(1): loaded http://localhost:45634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45634/tests/dromaeo/cssquery-prototype.html) 17:55:45 INFO - PROCESS | 13308 | RSS: Main: 173301760 17:55:45 INFO - PROCESS | 13308 | 17:58:48 INFO - PROCESS | 13308 | Cycle 1(1): loaded http://localhost:45634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45634/tests/dromaeo/cssquery-yui.html) 17:58:48 INFO - PROCESS | 13308 | RSS: Main: 177823744 17:58:48 INFO - PROCESS | 13308 | 18:01:51 INFO - PROCESS | 13308 | Cycle 1(1): loaded http://localhost:45634/tests/dromaeo/cssquery-yui.html (next: http://localhost:45634/tests/dromaeo/cssquery-dojo.html) 18:01:51 INFO - PROCESS | 13308 | RSS: Main: 265519104 18:01:51 INFO - PROCESS | 13308 | 18:01:51 INFO - PROCESS | 13308 | __start_tp_report 18:01:51 INFO - PROCESS | 13308 | _x_x_mozilla_page_load 18:01:51 INFO - PROCESS | 13308 | _x_x_mozilla_page_load_details 18:01:51 INFO - PROCESS | 13308 | |i|pagename|runs| 18:01:51 INFO - PROCESS | 13308 | |0;dojo.html;3208.117767613906;3244.107870335658;3254.381667483178;3267.607887053554;3291.045596776935;5392.325959255093;5468.562514998801;5493.2034854946005;5495.725213739312;5503.697296648683;5531.668099913998;5630.183623374608;5635.887282254363;5641.435856414357;5662.009148399024;5043.117454445466;5066.620003499734;5092.490750924896;5128.8974220515565;5156.123459011958;4859.052484765472;5087.10975579274;5135.794568217286;5143.177091665316;5147.48525147486;4847.054824309261;4980.053789779949;5004.674696144739;5037.395512538501;5051.242313652945;5008.198688209887;5034.647574669756;5048.899022019576;5113.309703190096;5138.794448222066;4949.8020079196785;4984.426790919055;5029.974850125726;5043.646944713872;5043.949560504385;5319.5478384337375;5364.490373414519;5435;5455.1544510600925;5501.559875209973;5893.116032595102;5906.675132867691;5912.290525136968;5990.2212712347555;6011.669358185298;6059.848503787441;6065.120557519179;6070.119832624289;6074.088886666991;6074.301455332649;5416.214648875891;5453.509184173404;5551.9722401387735;5555.583331250173;5618.578606604521;6107.206063211843;6125.050617154348;6140.324564297924;6140.4473597376455;6144.56988010835;5867.559933005042;5912.260967379078;5913.822585322448;5919.881602367928;5922.1412895130825;5752.453516915886;5791.536677065909;5830.5044071254415;5872;5873.794417195378;5920.644761314335;5925.73334199962;5931.3178984417345;5951.791687290924;5965.254343207099;5879;5924.6149000314845;5929.644221346647;5937.465628093492;5937.7921772737745;4510.458744950627;4553.54464553542;4572.474165471013;4591.288350305708;4644.396228490275;4132.586741325843;4143.502779666459;4177.5195852476745;4181.393697913785;4183.958160418357;5741.511971482387;5745.2818397700285;5746.540276777848;5752.165935939265;5757.366689664133;5830.737616807169;5863.120531920246;6000.0999850022845;6002.249718785152;6042.425969532887;5639.238702775073;5642.746076426571;5688.601797874192;5698.601097923106;5742.626729262584;5203.531682148625;5215.739213039333;5219.869503262373;5220.034293655686;5220.243064755665;6056.515478761777;6211.192544969215;6226.688665566703;6237.157983672237;6275.3724627536885;5829.650220986754;5873.4126587340925;5887.587868849139;5922.940770592239;5986.910196347146;6195.654878928828;6226.066090086523;6232.345603711545;6273.37266273369;6281.340459251713;5801.477866991991;5804.6807425590305;5856.238688970407;5857.5313974881055;5892.292924849045;5673.801416950387;5715.5713321500225;5939.049752039653;5981.820545383645;5984.910226346521;5897.764089436375;5910.202122713378;5918.644881306963;5929.644221346561;5933;5826.854328641818;5838.474537291664;5842.5325973921135;5858.297004359504;5878.470937615635;5529.861753456195;5636.013697602985;5772.769089236552;5864.384239654775;5885.911711324419;5889.911651325319;5948.791792287249;5982.58121931478;5983.311919129356;5985.072313791369;5527.723613819373;5780.797672081625;5787.479126878601;5790.10253410722;5804.361520232686 18:01:51 INFO - PROCESS | 13308 | |1;ext.html;578.9867731469927;606.2815563557185;638.9680515974203;645.2160624840817;684.1892357556293;32103.51844722328;43227.35158972614;43686.56313436865;43877;47160.52839471604;45702;46134.30798538025;46156.76921615395;46167.30749038767;46186.53813461864;8032.839343213132;8992.685256016024;9083.273338132933;9140.862887056699;9159.496227707474;8148.674053037871;10623.84064239037;10842.241043126984;10855.945720271387;11156;11069.612563560277;11112.833307500394;11145.777084458306;11146.442677866115;11158.386288754115;10906.454677266145;10966.287191332538;10968.945155274172;10969.780604387868;10988.340699558012;10700.30448020876;10814.837777433344;10821.080208182313;10822.24244302899;10822.404767737771;42972.78513607412;43440;43478.56521434777;43491.34762978558;43500.56499434997;3784.7539909906045;3886.300465916134;3890.6498415142773;3956.4460975463458;4167.124903770212;33005.33989320224;33034.339313213844;33089.50365744516;33123.52439091344;34248.31503369944;4216.241076606209;4234.788260586958;4250.128723611652;4250.957490425087;4268.87193384199;251241;251306;251582;251739;252923;61058;61405;61439.692801535704;61530;61609;39690.20619587592;40320.79839600842;40507.18985620271;43040.13919721588;43060;18790;18935;18948.05259737035;18959;18972.14625341863;12981.675458113623;13345.266010369329;14056.859431405555;14414.711705765825;14507.637309067146;19426.84317516987;20343.593128137356;20434.284800031928;20435.4891127723;20587.485312867;7585;7658.578778167142;7667.501612395176;7721.420893433015;7728.884066739003;981.788915383196;1055.672741450153;1062.9681109566725;1094.9616763413242;1150.1546363422879;34364.31271374559;34426.48360274598;34621.480677789856;34774.30451390958;34795;1065.8454524093963;1159.565163063851;1170.2568868768394;1194.7729931313022;1272.2620879889641;15455.38178472871;18082.457526274233;18258.543536411697;18566.164522596246;18626.250306171838;559415;559444;562841;563215;564886;62195.06707399392;62537;62610.373896260455;62686.373136268056;62766.37233627605;1317.4730107956702;1393.2058726525784;1439.6256973187046;1474.108164560447;1493.2682985337105;29979.70020299769;33607;33703.4944475838;34539.82730086333;34856.302873942885;51050.74474627603;51592;51701.741491292305;51762.741186293824;51835.481645184576;432580;434702;436964;437546;439100;29878.850605746833;30860.537091943188;31180.220494487818;32934.67065329412;32959;49805.75097124491;49915.75042124766;51120;51397.74301128471;51656.74171629118;43027.3545896818;43132.13735725205;43481.34777978269;43931.560684394026;44096;43357.34963975606;43705.34441983309;44065;44330;44708.55291447044;44289;45136.54863451324;45520.77239613781;45707;45817;36080.27839443249;38267.6173238264;38443;38716.80641596774;39284.214315714096;29834.657440415667;30091.548626771055;30168.832272611937;30249.546256805726;30430.543541846448 18:01:51 INFO - PROCESS | 13308 | |2;jquery.html;382.5234594465365;422.2989836870795;424.4502645579205;428.89492074441756;439.3300217168818;15108.320125594348;19305.903470482644;19584.314548990787;19881.90059049706;20148.294809681665;14098.859011409908;14847.55457336279;20255.797442025574;20335.389938301836;20400.693989590167;5188.247704082905;5441.156620723794;5452.236686863842;5456.372517160537;5463.071277882769;4040.474738284019;4240.406343111967;5232.581393488512;5782.826515204551;5969.492593129589;6056.818295451144;6059.7273122709585;6076.908846367308;6081.422264884829;6099.451049405553;6075.2405949256345;6545.770898018571;6568;6569.37590928861;6573.014047892831;5280.18157185633;5531.9723401383135;5928;5934.673592952386;5934.910976335358;13424.463021479129;13585.388657510337;13650.385732642055;13897.79153312701;13967.022308438414;2349.8237632177484;2393.6050551658955;2431.5744744669614;2669.599560065986;2715.2940235538704;10992.670219893416;11081.944590277079;11106.61126860564;14741.705165896621;15262.38950441981;1900.4773687235981;1979.1885327015998;2071.2336435518955;2101.548167144056;2102.568973360457;84412.57793710992;84896.57551712263;86656;87397;89065.55467222688;10612.840807387895;11443.942780286212;11769.411529423494;12071.517139314328;12101.394930253453;15196.316165772567;15514.767278490832;16214.108224047555;16272.18639068042;16804;8785.868211976698;8828.249598784047;8925.419847709878;8979.820403591892;9042.231410330063;8555.657773688983;8603.78490537729;8636.136386361313;8756.824863502694;8808.735737927873;4901.779419926112;4956.5786908112495;5061.114304996611;5125.923111153335;5266.8419947401635;2119.5337025854287;2134.6371116910163;2143.2498625480957;2147.946301342479;2150.2689085710936;930.2232635749225;986.659602437158;1057.471264367816;1060.2101434431397;1101.9338839669645;20431.693524597144;20523.4869128273;20737.897672753523;21030.263940762;21182.364529064154;1008.4503945349802;1062.5377960587168;1062.8830828608848;1093.8742044664807;1128.2414496556005;10361.792764144826;11464.828027579593;11533.942330288462;11606.129540284512;11717.472713727731;506319;510610;515952;516078;524223;93490;96194.51902740581;96504;98038.50980745051;98420.50789746005;938.8403971324891;959.4579062829479;981.9361741486781;985.113397941858;1008.5612758450097;17637.559061023578;17869.28522859071;17912.820871791115;17956.371526996492;18381.81618183801;43520;43933.901652458946;43976.120477589626;44018.559814401444;44647.77676111729;58697.70651146717;58846;59163.70418148054;59672.40327596669;60093;5746.885062298814;6695.631740254333;8693.739187824376;8986.652002199722;9011;11868.40657967081;13018.414171362121;13227.603171904859;13431.731365372832;14150.716985660434;11899.107566932687;12151.635450936486;12261.69345766363;12270.141090123605;12345;5544.0575102231915;8990;11612.187146899636;11669.714502703177;12225.205361651464;12138.239955206622;12169.878301217228;12222.083343749433;12246.510139594317;12748.553800616934;7708.537487750753;8320.583970801315;9064.501452419916;9079.954600226956;9375;10399.740006499898;12292.262464252173;12428.689282768004;12471.674527244544;12684.175528590613 18:01:51 INFO - PROCESS | 13308 | |3;mootools.html;1346.1182925184007;1480.5928369698331;1509.3208056374633;1636.1492024147444;1850.7964123946356;7825.5304681719135;8282.585870706464;8681.131886811316;9005.189532942033;9016.143466370684;9050.411723238001;9132.178103970642;9141.725748227547;9146.22257108145;9148.039455857139;2461.8769061546896;2479.47930934504;2484.8757562121823;2486.4405508760565;2493.289412517433;2441.340837973746;2498.8625625590585;2499.2252401755422;2501.687289088864;2502.5620516409645;2466.8643224622638;2468.543319485892;2470.0737223541173;2470.493548822496;2482.491089326693;2355.8468699534474;2361.988190059056;2379.1078345620394;2399.868007259609;2438.926832195028;2471.9011239550396;2485.192312498445;2489.3154382544762;2509.0716434919013;2510.472800711853;8809.42738721981;8812.250958668521;8983.416077954913;9089.954550227207;9095.135962083592;5411.107167317388;5550.4449555044575;5561.165825126223;5561.360443549003;5564.10974244119;3500.9824950875336;3632.473291372736;3650.7627004244905;3709.8330575124182;3724.9068773280615;1124.1063354633086;1128.836318733779;1159.7100724818795;1164.551647615674;1173.2960223865698;11947.044236461063;11952.940235298855;12038.879611203864;12044.156909016372;12110.515579376903;4431.246688063037;4674.719516829001;4754.429468463806;4773.069251495925;4794.2808578712775;10078;10118.645847395306;10123.848142277871;10124.797504049879;10130.645427410005;5351.785928562892;5390.110631745718;5396.64921780083;5410.48600382963;5414.431484694129;4230.323148296257;4361.956380436219;5021.623378246646;5021.698698078127;5076.466970968069;4049.635532802062;4079.97960010204;4161;4192.496900371914;4202.117555313357;1239.324568110382;1262.5770366927181;1264.1214356022476;1268.1566758105942;1275.324078238535;932.9626814927462;1002.7092143278368;1034.110664828247;1040.7450174707094;1065.1053115383115;6049.727762250709;6068.939310606837;6200.627962322184;6318.6524741138755;6326.841828954313;470.2569939495589;478.4234996828813;485.8153901517401;490.07620635102376;511.53194826733863;4253.680973926967;4391.978040109779;4453.287474004209;4459.710118842329;4513.5486451355255;10855.2401331906;11274.098072154207;11280.097592192606;11297.096232301396;11375.03312218454;11285.71785705364;11293.096552275798;11293.15301352402;11304.547818087185;11305.321680699184;8092.635831387602;8427.410081294373;8434.74695759116;8533.232009119209;8636;6219.813405597839;6338.619682819046;6428.903566446414;6429.32492088324;6535.934640653532;10234.590616375262;10461.26771126014;10478.895211047791;10486.842697359392;10577.788444231226;10279.177665786869;10448.68653940383;10498.737531561466;10530.684079477627;10624.990625890528;7961.243681850215;7990.3208227299;7994.600269986594;8039.718609848627;8067.193280672121;8401.831963360577;8409.032961209294;8446.83106337882;8449.112843151626;8470.915290847013;7366.263373662591;7383.852322953619;7500.399968002655;7633.923660763321;7669.34810541088;7168.068151140318;7341.3392794648735;7365.2634736525915;7409.444291678254;7494.737684181027;7330.706771729071;7488.8876666848955;7493.288137626917;7542.170361260147;7543.057117860268;5462.535684466865;5464.836054918359;5537.5569954402745;5547.694876781816;5700.714964251853;5511.338639363142;5538.639988400902;5613.803516876889;5622.128570071645;5687.43125687428 18:01:51 INFO - PROCESS | 13308 | |4;prototype.html;355.82208895552225;356.4617427684197;359.34060998068543;359.73918908791114;362.53052297275025;5316;5337.5196232339085;5345.572354211668;5359.946400535999;5384.246205531229;5279.4984476474765;5309.203619457084;5331.680099194051;5337.973310133453;5347.572194224463;3741.7567858089137;3978.860739874105;4116.217918595457;4191.245575796355;4212;4192.706510544263;4203.558626344236;4211.768352740598;4211.789410529476;4225.535191128974;4192.580741925798;4193.077522944947;4203.243416185085;4209.779164042439;4218.240716670998;3986.641202291793;4106.77412742299;4113.424120623115;4152.294110001307;4234.640055595262;3728.608496107897;3742;3744.887653370376;3745.4943582616543;3755.793431361274;5125.3080834087295;5135.281060651511;5154.994776018678;5186.896262074737;5196.29849970253;4703.836235331752;4762.880927976794;4793.3049707792525;4811.326414302001;4817.494163112858;5499;5513.696746678931;5517.751701173457;5523.364813046511;5531.723413829292;4143.6892233082635;4144.336906095041;4150.568054021358;4161.417401563784;4168.687348448848;5649.802256920988;5703.4011428799795;5725.599208055438;5732.914006289867;5792.1890935268675;4209.842293369286;4214.241436541452;4215.7352794161625;4232.280512312914;4259.041715613962;4276.422682937764;4296.699231053796;4311.504177019683;4315.352697095461;4317.41714868495;4622.695494240304;4747.833825816149;4801.591864691541;4801.927971080437;4831.541003604652;5521.751521181556;5531.917021244684;5544.584156188222;5556.222128901957;5568.276124103841;1436.1670231265841;1437.058726534122;1451.7894905238682;1453.7019910918236;1454.7817827325773;968.941863488193;1015.8323876560432;1018.8487009679016;1021.2646894236138;1034.637876743149;5232.869178270574;5249.737513124405;5262.368515778131;5273.78904843802;5317.601179911522;5487.945120548743;5517.779288828482;5521.944780552223;5525;5543.750531226105;4967.105920934267;5200.401953775288;5237.973810130925;5254.4220135785035;5347.893042139135;2858.44260369226;2884.841333726665;2886.292858249742;2889.3787835615444;2908.7672986161056;5621.831345059655;5651.463111004448;5664.858378540487;5670.914936275959;5699.686517241592;5246.97376513115;5488.012157811552;5496.47162305336;5508.889822203533;5520.861978450571;5633.6619802811965;5763.109900816932;5922.489765109869;5926.844265368211;5930.851728706731;5639.661620302795;5650.29371328584;5655.943440565542;5659.349174844946;5661.943380566142;5488.725563721878;5578.410153106345;5592.5525957922455;5611.1022236443605;5622.5501959842295;5900;5901.7639294427745;5920.526357891445;5922.200502932222;5942.168096466412;4154.106867023484;4168.7707176105605;4178.8328466860985;4192.790360482025;4197.181549597921;5575.665460072409;5667.688277144632;5674.631148975303;5679.545636349165;5706.172604972338;5514.80698175562;5551.333839939233;5553.9444605555045;5600.955651187206;5611.579131565068;5285.810692594136;5517.282753242052;5529.534673311495;5532.723363831712;5537.363203231519;5484.533814625802;5499.800079968045;5548.195511650707;5548.472895074961;5552.916706249329;5528.585356098229;5574.693391863487;5576.888462230651;5583.497485226349;5598.972005139948;5285.260063591178;5390.865228369322;5442.482964118402;5459.426760190282;5467.835964921059 18:01:51 INFO - PROCESS | 13308 | |5;yui.html;819.0539926385023;823.3001948343908;825.8967629046373;861.7285555050158;877.3810176622776;14261.714765704679;14804;14975.925120374382;14986.550403487885;15001.324940377683;14226.92886535566;14472.927635361808;14596.197209153492;14645.26773661318;14654.706905861876;710.7050574011805;726.2664708644281;834.0825092398344;848.3637272045966;852.5098068610542;835.3359079531787;857.3098655582254;857.5797859049052;867.1588559097665;867.8351113288455;900.572228191607;910.1217325281102;910.4355299714153;912.2473958983832;912.6851236323457;748.5321673953779;763.3435245688703;907.2016625369665;907.2333877873186;907.2379201470764;640.5580149696741;657.4904449051975;660.5046215338496;666.2804171494774;666.5534092158266;14166.92916535421;14193.716125677533;14197.929010354883;14227;14265.857341426557;13926.860731392657;13977;14205.36075876588;14302.64243393913;14327.856721432756;12064.758704825943;12190.268583884996;12225.266484010988;12325.938370308091;12529.310887901162;4419.138268037734;4420.557944205586;4465.022007173453;4535.365048893158;4541.954580454186;61875;62021;62148.68925655388;63337.366626333605;64902.3509764901;11275.210735248455;11334;11419.200655954004;11575.073994080454;11690.415479226005;20233.291834785712;20348.18607255693;20349.49126271855;20371.388858334274;20375.796242037686;8044;8058.758237252891;8152.103268640445;8323.5005899645;8676.566171691517;4630.490646028934;4883.145449546315;4902.656814023056;5054.721990290495;5076.8476945690945;3387.796732196076;3494.3710132175943;3495.8252087395526;3497.4753786932165;3497.89506314811;627.4133685004444;635.1140159477595;638.0939066525544;640.6092283706935;640.7725257533508;713.4435140590348;723.1430754555763;729.2525161709184;733.5561984998999;771.7260372567657;9553.522323883779;9575.760605984768;9606.087421695067;9620.567074481665;10146.82005729806;631.6810010944444;724.7101159536122;730.1092666946317;740.2634378793027;751.1136858507015;4442.6890117691455;4605.746683932349;4613.907721845544;4685.695429797052;4746.38297021385;55340.16989745157;68305;87760.5611971936;93531.53234233786;93923.53038234766;63335.36664633295;76527;76758.61620691861;77758.6112069436;79589.60205199053;65891;66024.33975660182;66247.66876165588;66612.666936665;67807.66096169487;9934.403935763878;10269.155675977161;10324.122449591869;10584.523696433833;10631.627893023708;33973.66026339804;34710.78512252059;43449.782751086044;44647.55352446434;45105.774471127435;54906.45093549173;58061.02274194937;60413;63420;64444;13186.340682966005;13443.395047222702;13507.257100859548;13631.318434078456;14045;14227.217503037433;14296.499622513162;15056.171910545025;15296.923515382798;15829.762553561475;11572.18994670365;12552.184108032949;13523.323833808467;13689.383977721225;14407.639809004439;13194.472221111047;13527.458901643824;13954.302284885918;14056.718865622835;14212.21832799206;13434.529791457253;14122.293885305487;14209.147451152963;14330;14909.403623855358;11433.714157145805;11925.522979081086;12003.840432993882;12063.81904271419;12432.440540175894;11820.468078936641;11845.940770296093;12051.216670916363;12286.385680716106;12303.692407689521 18:01:51 INFO - PROCESS | 13308 | __end_tp_report 18:01:51 INFO - PROCESS | 13308 | __start_cc_report 18:01:51 INFO - PROCESS | 13308 | _x_x_mozilla_cycle_collect,1563 18:01:51 INFO - PROCESS | 13308 | __end_cc_report 18:01:51 INFO - PROCESS | 13308 | __startTimestamp1483668111836__endTimestamp 18:01:51 INFO - PROCESS | 13308 | 18:01:51 INFO - PROCESS | 13308 | ------- Summary: start ------- 18:01:51 INFO - PROCESS | 13308 | Number of tests: 6 18:01:51 INFO - PROCESS | 13308 | 18:01:51 INFO - PROCESS | 13308 | [#0] dojo.html Cycles:165 Average:5540.19 Median:5780.80 stddev:625.03 (10.8%) stddev-sans-first:599.57 18:01:51 INFO - PROCESS | 13308 | Values: 3208.1 3244.1 3254.4 3267.6 3291.0 5392.3 5468.6 5493.2 5495.7 5503.7 5531.7 5630.2 5635.9 5641.4 5662.0 5043.1 5066.6 5092.5 5128.9 5156.1 4859.1 5087.1 5135.8 5143.2 5147.5 4847.1 4980.1 5004.7 5037.4 5051.2 5008.2 5034.6 5048.9 5113.3 5138.8 4949.8 4984.4 5030.0 5043.6 5043.9 5319.5 5364.5 5435.0 5455.2 5501.6 5893.1 5906.7 5912.3 5990.2 6011.7 6059.8 6065.1 6070.1 6074.1 6074.3 5416.2 5453.5 5552.0 5555.6 5618.6 6107.2 6125.1 6140.3 6140.4 6144.6 5867.6 5912.3 5913.8 5919.9 5922.1 5752.5 5791.5 5830.5 5872.0 5873.8 5920.6 5925.7 5931.3 5951.8 5965.3 5879.0 5924.6 5929.6 5937.5 5937.8 4510.5 4553.5 4572.5 4591.3 4644.4 4132.6 4143.5 4177.5 4181.4 4184.0 5741.5 5745.3 5746.5 5752.2 5757.4 5830.7 5863.1 6000.1 6002.2 6042.4 5639.2 5642.7 5688.6 5698.6 5742.6 5203.5 5215.7 5219.9 5220.0 5220.2 6056.5 6211.2 6226.7 6237.2 6275.4 5829.7 5873.4 5887.6 5922.9 5986.9 6195.7 6226.1 6232.3 6273.4 6281.3 5801.5 5804.7 5856.2 5857.5 5892.3 5673.8 5715.6 5939.0 5981.8 5984.9 5897.8 5910.2 5918.6 5929.6 5933.0 5826.9 5838.5 5842.5 5858.3 5878.5 5529.9 5636.0 5772.8 5864.4 5885.9 5889.9 5948.8 5982.6 5983.3 5985.1 5527.7 5780.8 5787.5 5790.1 5804.4 18:01:51 INFO - PROCESS | 13308 | 18:01:51 INFO - PROCESS | 13308 | [#1] ext.html Cycles:180 Average:59056.89 Median:21587.43 stddev:115660.67 (535.8%) stddev-sans-first:115901.79 18:01:51 INFO - PROCESS | 13308 | Values: 579.0 606.3 639.0 645.2 684.2 32103.5 43227.4 43686.6 43877.0 47160.5 45702.0 46134.3 46156.8 46167.3 46186.5 8032.8 8992.7 9083.3 9140.9 9159.5 8148.7 10623.8 10842.2 10855.9 11156.0 11069.6 11112.8 11145.8 11146.4 11158.4 10906.5 10966.3 10968.9 10969.8 10988.3 10700.3 10814.8 10821.1 10822.2 10822.4 42972.8 43440.0 43478.6 43491.3 43500.6 3784.8 3886.3 3890.6 3956.4 4167.1 33005.3 33034.3 33089.5 33123.5 34248.3 4216.2 4234.8 4250.1 4251.0 4268.9 251241.0 251306.0 251582.0 251739.0 252923.0 61058.0 61405.0 61439.7 61530.0 61609.0 39690.2 40320.8 40507.2 43040.1 43060.0 18790.0 18935.0 18948.1 18959.0 18972.1 12981.7 13345.3 14056.9 14414.7 14507.6 19426.8 20343.6 20434.3 20435.5 20587.5 7585.0 7658.6 7667.5 7721.4 7728.9 981.8 1055.7 1063.0 1095.0 1150.2 34364.3 34426.5 34621.5 34774.3 34795.0 1065.8 1159.6 1170.3 1194.8 1272.3 15455.4 18082.5 18258.5 18566.2 18626.3 559415.0 559444.0 562841.0 563215.0 564886.0 62195.1 62537.0 62610.4 62686.4 62766.4 1317.5 1393.2 1439.6 1474.1 1493.3 29979.7 33607.0 33703.5 34539.8 34856.3 51050.7 51592.0 51701.7 51762.7 51835.5 432580.0 434702.0 436964.0 437546.0 439100.0 29878.9 30860.5 31180.2 32934.7 32959.0 49805.8 49915.8 51120.0 51397.7 51656.7 43027.4 43132.1 43481.3 43931.6 44096.0 43357.3 43705.3 44065.0 44330.0 44708.6 44289.0 45136.5 45520.8 45707.0 45817.0 36080.3 38267.6 38443.0 38716.8 39284.2 29834.7 30091.5 30168.8 30249.5 30430.5 18:01:51 INFO - PROCESS | 13308 | 18:01:51 INFO - PROCESS | 13308 | [#2] jquery.html Cycles:180 Average:29987.19 Median:2692.45 stddev:84944.46 (3154.9%) stddev-sans-first:85153.67 18:01:51 INFO - PROCESS | 13308 | Values: 382.5 422.3 424.5 428.9 439.3 15108.3 19305.9 19584.3 19881.9 20148.3 14098.9 14847.6 20255.8 20335.4 20400.7 5188.2 5441.2 5452.2 5456.4 5463.1 4040.5 4240.4 5232.6 5782.8 5969.5 6056.8 6059.7 6076.9 6081.4 6099.5 6075.2 6545.8 6568.0 6569.4 6573.0 5280.2 5532.0 5928.0 5934.7 5934.9 13424.5 13585.4 13650.4 13897.8 13967.0 2349.8 2393.6 2431.6 2669.6 2715.3 10992.7 11081.9 11106.6 14741.7 15262.4 1900.5 1979.2 2071.2 2101.5 2102.6 84412.6 84896.6 86656.0 87397.0 89065.6 10612.8 11443.9 11769.4 12071.5 12101.4 15196.3 15514.8 16214.1 16272.2 16804.0 8785.9 8828.2 8925.4 8979.8 9042.2 8555.7 8603.8 8636.1 8756.8 8808.7 4901.8 4956.6 5061.1 5125.9 5266.8 2119.5 2134.6 2143.2 2147.9 2150.3 930.2 986.7 1057.5 1060.2 1101.9 20431.7 20523.5 20737.9 21030.3 21182.4 1008.5 1062.5 1062.9 1093.9 1128.2 10361.8 11464.8 11533.9 11606.1 11717.5 506319.0 510610.0 515952.0 516078.0 524223.0 93490.0 96194.5 96504.0 98038.5 98420.5 938.8 959.5 981.9 985.1 1008.6 17637.6 17869.3 17912.8 17956.4 18381.8 43520.0 43933.9 43976.1 44018.6 44647.8 58697.7 58846.0 59163.7 59672.4 60093.0 5746.9 6695.6 8693.7 8986.7 9011.0 11868.4 13018.4 13227.6 13431.7 14150.7 11899.1 12151.6 12261.7 12270.1 12345.0 5544.1 8990.0 11612.2 11669.7 12225.2 12138.2 12169.9 12222.1 12246.5 12748.6 7708.5 8320.6 9064.5 9080.0 9375.0 10399.7 12292.3 12428.7 12471.7 12684.2 18:01:51 INFO - PROCESS | 13308 | 18:01:51 INFO - PROCESS | 13308 | [#3] mootools.html Cycles:180 Average:5930.53 Median:4486.63 stddev:3322.94 (74.1%) stddev-sans-first:3314.40 18:01:51 INFO - PROCESS | 13308 | Values: 1346.1 1480.6 1509.3 1636.1 1850.8 7825.5 8282.6 8681.1 9005.2 9016.1 9050.4 9132.2 9141.7 9146.2 9148.0 2461.9 2479.5 2484.9 2486.4 2493.3 2441.3 2498.9 2499.2 2501.7 2502.6 2466.9 2468.5 2470.1 2470.5 2482.5 2355.8 2362.0 2379.1 2399.9 2438.9 2471.9 2485.2 2489.3 2509.1 2510.5 8809.4 8812.3 8983.4 9090.0 9095.1 5411.1 5550.4 5561.2 5561.4 5564.1 3501.0 3632.5 3650.8 3709.8 3724.9 1124.1 1128.8 1159.7 1164.6 1173.3 11947.0 11952.9 12038.9 12044.2 12110.5 4431.2 4674.7 4754.4 4773.1 4794.3 10078.0 10118.6 10123.8 10124.8 10130.6 5351.8 5390.1 5396.6 5410.5 5414.4 4230.3 4362.0 5021.6 5021.7 5076.5 4049.6 4080.0 4161.0 4192.5 4202.1 1239.3 1262.6 1264.1 1268.2 1275.3 933.0 1002.7 1034.1 1040.7 1065.1 6049.7 6068.9 6200.6 6318.7 6326.8 470.3 478.4 485.8 490.1 511.5 4253.7 4392.0 4453.3 4459.7 4513.5 10855.2 11274.1 11280.1 11297.1 11375.0 11285.7 11293.1 11293.2 11304.5 11305.3 8092.6 8427.4 8434.7 8533.2 8636.0 6219.8 6338.6 6428.9 6429.3 6535.9 10234.6 10461.3 10478.9 10486.8 10577.8 10279.2 10448.7 10498.7 10530.7 10625.0 7961.2 7990.3 7994.6 8039.7 8067.2 8401.8 8409.0 8446.8 8449.1 8470.9 7366.3 7383.9 7500.4 7633.9 7669.3 7168.1 7341.3 7365.3 7409.4 7494.7 7330.7 7488.9 7493.3 7542.2 7543.1 5462.5 5464.8 5537.6 5547.7 5700.7 5511.3 5538.6 5613.8 5622.1 5687.4 18:01:51 INFO - PROCESS | 13308 | 18:01:51 INFO - PROCESS | 13308 | [#4] prototype.html Cycles:180 Average:4676.15 Median:5297.51 stddev:1341.28 (25.3%) stddev-sans-first:1305.26 18:01:51 INFO - PROCESS | 13308 | Values: 355.8 356.5 359.3 359.7 362.5 5316.0 5337.5 5345.6 5359.9 5384.2 5279.5 5309.2 5331.7 5338.0 5347.6 3741.8 3978.9 4116.2 4191.2 4212.0 4192.7 4203.6 4211.8 4211.8 4225.5 4192.6 4193.1 4203.2 4209.8 4218.2 3986.6 4106.8 4113.4 4152.3 4234.6 3728.6 3742.0 3744.9 3745.5 3755.8 5125.3 5135.3 5155.0 5186.9 5196.3 4703.8 4762.9 4793.3 4811.3 4817.5 5499.0 5513.7 5517.8 5523.4 5531.7 4143.7 4144.3 4150.6 4161.4 4168.7 5649.8 5703.4 5725.6 5732.9 5792.2 4209.8 4214.2 4215.7 4232.3 4259.0 4276.4 4296.7 4311.5 4315.4 4317.4 4622.7 4747.8 4801.6 4801.9 4831.5 5521.8 5531.9 5544.6 5556.2 5568.3 1436.2 1437.1 1451.8 1453.7 1454.8 968.9 1015.8 1018.8 1021.3 1034.6 5232.9 5249.7 5262.4 5273.8 5317.6 5487.9 5517.8 5521.9 5525.0 5543.8 4967.1 5200.4 5238.0 5254.4 5347.9 2858.4 2884.8 2886.3 2889.4 2908.8 5621.8 5651.5 5664.9 5670.9 5699.7 5247.0 5488.0 5496.5 5508.9 5520.9 5633.7 5763.1 5922.5 5926.8 5930.9 5639.7 5650.3 5655.9 5659.3 5661.9 5488.7 5578.4 5592.6 5611.1 5622.6 5900.0 5901.8 5920.5 5922.2 5942.2 4154.1 4168.8 4178.8 4192.8 4197.2 5575.7 5667.7 5674.6 5679.5 5706.2 5514.8 5551.3 5553.9 5601.0 5611.6 5285.8 5517.3 5529.5 5532.7 5537.4 5484.5 5499.8 5548.2 5548.5 5552.9 5528.6 5574.7 5576.9 5583.5 5599.0 5285.3 5390.9 5442.5 5459.4 5467.8 18:01:51 INFO - PROCESS | 13308 | 18:01:51 INFO - PROCESS | 13308 | [#5] yui.html Cycles:180 Average:17576.68 Median:4573.85 stddev:22375.29 (489.2%) stddev-sans-first:22402.68 18:01:51 INFO - PROCESS | 13308 | Values: 819.1 823.3 825.9 861.7 877.4 14261.7 14804.0 14975.9 14986.6 15001.3 14226.9 14472.9 14596.2 14645.3 14654.7 710.7 726.3 834.1 848.4 852.5 835.3 857.3 857.6 867.2 867.8 900.6 910.1 910.4 912.2 912.7 748.5 763.3 907.2 907.2 907.2 640.6 657.5 660.5 666.3 666.6 14166.9 14193.7 14197.9 14227.0 14265.9 13926.9 13977.0 14205.4 14302.6 14327.9 12064.8 12190.3 12225.3 12325.9 12529.3 4419.1 4420.6 4465.0 4535.4 4542.0 61875.0 62021.0 62148.7 63337.4 64902.4 11275.2 11334.0 11419.2 11575.1 11690.4 20233.3 20348.2 20349.5 20371.4 20375.8 8044.0 8058.8 8152.1 8323.5 8676.6 4630.5 4883.1 4902.7 5054.7 5076.8 3387.8 3494.4 3495.8 3497.5 3497.9 627.4 635.1 638.1 640.6 640.8 713.4 723.1 729.3 733.6 771.7 9553.5 9575.8 9606.1 9620.6 10146.8 631.7 724.7 730.1 740.3 751.1 4442.7 4605.7 4613.9 4685.7 4746.4 55340.2 68305.0 87760.6 93531.5 93923.5 63335.4 76527.0 76758.6 77758.6 79589.6 65891.0 66024.3 66247.7 66612.7 67807.7 9934.4 10269.2 10324.1 10584.5 10631.6 33973.7 34710.8 43449.8 44647.6 45105.8 54906.5 58061.0 60413.0 63420.0 64444.0 13186.3 13443.4 13507.3 13631.3 14045.0 14227.2 14296.5 15056.2 15296.9 15829.8 11572.2 12552.2 13523.3 13689.4 14407.6 13194.5 13527.5 13954.3 14056.7 14212.2 13434.5 14122.3 14209.1 14330.0 14909.4 11433.7 11925.5 12003.8 12063.8 12432.4 11820.5 11845.9 12051.2 12286.4 12303.7 18:01:51 INFO - PROCESS | 13308 | -------- Summary: end -------- 18:01:51 INFO - PROCESS | 13308 | 18:01:52 INFO - TEST-INFO | 13308: exit 0 18:01:52 INFO - TEST-OK | dromaeo_css | took 1116008ms 18:01:52 INFO - TEST-START | kraken 18:01:52 INFO - operating with platform_type : linux_ 18:01:52 INFO - Initialising browser for kraken test... 18:01:52 INFO - TEST-INFO | started process 13629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuEKMeH/profile http://localhost:45634/getInfo.html) 18:01:56 INFO - PROCESS | 13629 | __metrics Screen width/height:1600/1200 18:01:56 INFO - PROCESS | 13629 | colorDepth:24 18:01:56 INFO - PROCESS | 13629 | Browser inner width/height: 1024/697 18:01:56 INFO - PROCESS | 13629 | __metrics 18:01:57 INFO - PROCESS | 13629 | 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" 18:01:57 INFO - PROCESS | 13629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:01:57 INFO - PROCESS | 13629 | console.error: PushService: 18:01:57 INFO - PROCESS | 13629 | stateChangeProcessEnqueue: Error transitioning state 18:01:57 INFO - PROCESS | 13629 | UnknownError 18:01:58 INFO - TEST-INFO | 13629: exit 0 18:01:58 INFO - Browser initialized. 18:01:58 INFO - Running cycle 1/1 for kraken test... 18:01:58 INFO - TEST-INFO | started process 13722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuEKMeH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:10 INFO - PROCESS | 13722 | RSS: Main: 147574784 18:02:10 INFO - PROCESS | 13722 | 18:02:12 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45634/tests/kraken/driver.html?testName=audio-beat-detection) 18:02:13 INFO - PROCESS | 13722 | RSS: Main: 188964864 18:02:13 INFO - PROCESS | 13722 | 18:02:16 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45634/tests/kraken/driver.html?testName=audio-dft) 18:02:16 INFO - PROCESS | 13722 | RSS: Main: 178356224 18:02:16 INFO - PROCESS | 13722 | 18:02:19 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45634/tests/kraken/driver.html?testName=audio-fft) 18:02:20 INFO - PROCESS | 13722 | RSS: Main: 269762560 18:02:20 INFO - PROCESS | 13722 | 18:02:22 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45634/tests/kraken/driver.html?testName=audio-oscillator) 18:02:22 INFO - PROCESS | 13722 | RSS: Main: 176025600 18:02:22 INFO - PROCESS | 13722 | 18:02:24 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:02:25 INFO - PROCESS | 13722 | RSS: Main: 178450432 18:02:25 INFO - PROCESS | 13722 | 18:02:28 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45634/tests/kraken/driver.html?testName=imaging-darkroom) 18:02:29 INFO - PROCESS | 13722 | RSS: Main: 217600000 18:02:29 INFO - PROCESS | 13722 | 18:02:32 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45634/tests/kraken/driver.html?testName=imaging-desaturate) 18:02:32 INFO - PROCESS | 13722 | RSS: Main: 215973888 18:02:32 INFO - PROCESS | 13722 | 18:02:35 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45634/tests/kraken/driver.html?testName=json-parse-financial) 18:02:36 INFO - PROCESS | 13722 | RSS: Main: 214732800 18:02:36 INFO - PROCESS | 13722 | 18:02:37 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:02:38 INFO - PROCESS | 13722 | RSS: Main: 177217536 18:02:38 INFO - PROCESS | 13722 | 18:02:39 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45634/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:02:40 INFO - PROCESS | 13722 | RSS: Main: 183287808 18:02:40 INFO - PROCESS | 13722 | 18:02:42 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:02:43 INFO - PROCESS | 13722 | RSS: Main: 190021632 18:02:43 INFO - PROCESS | 13722 | 18:02:45 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:02:46 INFO - PROCESS | 13722 | RSS: Main: 198438912 18:02:46 INFO - PROCESS | 13722 | 18:02:49 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:02:49 INFO - PROCESS | 13722 | RSS: Main: 194682880 18:02:49 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | Cycle 1(1): loaded http://localhost:45634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45634/tests/kraken/driver.html?testName=ai-astar) 18:02:51 INFO - PROCESS | 13722 | RSS: Main: 247197696 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | __start_tp_report 18:02:51 INFO - PROCESS | 13722 | _x_x_mozilla_page_load 18:02:51 INFO - PROCESS | 13722 | _x_x_mozilla_page_load_details 18:02:51 INFO - PROCESS | 13722 | |i|pagename|runs| 18:02:51 INFO - PROCESS | 13722 | |0;ai-astar;101;112;110;111;110;109;110;111;110;109 18:02:51 INFO - PROCESS | 13722 | |1;audio-beat-detection;146;118;118;151;119;120;118;128;155;119 18:02:51 INFO - PROCESS | 13722 | |2;audio-dft;160;161;162;159;162;160;160;160;160;160 18:02:51 INFO - PROCESS | 13722 | |3;audio-fft;75;75;77;122;75;76;76;76;98;84 18:02:51 INFO - PROCESS | 13722 | |4;audio-oscillator;81;82;121;82;82;82;99;82;82;114 18:02:51 INFO - PROCESS | 13722 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;117;117;117 18:02:51 INFO - PROCESS | 13722 | |6;imaging-darkroom;145;146;145;146;146;146;146;146;146;146 18:02:51 INFO - PROCESS | 13722 | |7;imaging-desaturate;85;85;84;86;84;84;84;83;84;85 18:02:51 INFO - PROCESS | 13722 | |8;json-parse-financial;54;52;52;52;52;51;52;53;52;53 18:02:51 INFO - PROCESS | 13722 | |9;json-stringify-tinderbox;57;58;58;58;58;57;57;58;57;60 18:02:51 INFO - PROCESS | 13722 | |10;stanford-crypto-aes;75;77;83;75;75;75;74;83;82;77 18:02:51 INFO - PROCESS | 13722 | |11;stanford-crypto-ccm;123;122;122;122;128;128;127;120;164;120 18:02:51 INFO - PROCESS | 13722 | |12;stanford-crypto-pbkdf2;155;156;155;154;159;157;156;152;153;155 18:02:51 INFO - PROCESS | 13722 | |13;stanford-crypto-sha256-iterative;65;63;62;62;64;63;73;63;62;61 18:02:51 INFO - PROCESS | 13722 | __end_tp_report 18:02:51 INFO - PROCESS | 13722 | __start_cc_report 18:02:51 INFO - PROCESS | 13722 | _x_x_mozilla_cycle_collect,1614 18:02:51 INFO - PROCESS | 13722 | __end_cc_report 18:02:51 INFO - PROCESS | 13722 | __startTimestamp1483668171539__endTimestamp 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | ------- Summary: start ------- 18:02:51 INFO - PROCESS | 13722 | Number of tests: 14 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:0.97 18:02:51 INFO - PROCESS | 13722 | Values: 101.0 112.0 110.0 111.0 110.0 109.0 110.0 111.0 110.0 109.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:124.00 stddev:15.25 (12.3%) stddev-sans-first:14.92 18:02:51 INFO - PROCESS | 13722 | Values: 146.0 118.0 118.0 151.0 119.0 120.0 118.0 128.0 155.0 119.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 18:02:51 INFO - PROCESS | 13722 | Values: 160.0 161.0 162.0 159.0 162.0 160.0 160.0 160.0 160.0 160.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:15.35 (20.2%) stddev-sans-first:15.98 18:02:51 INFO - PROCESS | 13722 | Values: 75.0 75.0 77.0 122.0 75.0 76.0 76.0 76.0 98.0 84.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:15.20 (18.5%) stddev-sans-first:15.71 18:02:51 INFO - PROCESS | 13722 | Values: 81.0 82.0 121.0 82.0 82.0 82.0 99.0 82.0 82.0 114.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 18:02:51 INFO - PROCESS | 13722 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 18:02:51 INFO - PROCESS | 13722 | Values: 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 18:02:51 INFO - PROCESS | 13722 | Values: 85.0 85.0 84.0 86.0 84.0 84.0 84.0 83.0 84.0 85.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.60 18:02:51 INFO - PROCESS | 13722 | Values: 54.0 52.0 52.0 52.0 52.0 51.0 52.0 53.0 52.0 53.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 18:02:51 INFO - PROCESS | 13722 | Values: 57.0 58.0 58.0 58.0 58.0 57.0 57.0 58.0 57.0 60.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:3.63 (4.7%) stddev-sans-first:3.72 18:02:51 INFO - PROCESS | 13722 | Values: 75.0 77.0 83.0 75.0 75.0 75.0 74.0 83.0 82.0 77.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:125.00 stddev:13.15 (10.5%) stddev-sans-first:13.84 18:02:51 INFO - PROCESS | 13722 | Values: 123.0 122.0 122.0 122.0 128.0 128.0 127.0 120.0 164.0 120.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.50 stddev:1.99 (1.3%) stddev-sans-first:2.11 18:02:51 INFO - PROCESS | 13722 | Values: 155.0 156.0 155.0 154.0 159.0 157.0 156.0 152.0 153.0 155.0 18:02:51 INFO - PROCESS | 13722 | 18:02:51 INFO - PROCESS | 13722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:3.43 (5.4%) stddev-sans-first:3.61 18:02:51 INFO - PROCESS | 13722 | Values: 65.0 63.0 62.0 62.0 64.0 63.0 73.0 63.0 62.0 61.0 18:02:51 INFO - PROCESS | 13722 | -------- Summary: end -------- 18:02:51 INFO - PROCESS | 13722 | 18:02:52 INFO - TEST-INFO | 13722: exit 0 18:02:52 INFO - TEST-OK | kraken | took 60010ms 18:02:52 INFO - SUITE-END | took 1176s 18:02:52 INFO - Completed test suite (00:19:36) 18:02:52 INFO - javascript benchmark 18:02:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.117767613906, 3244.107870335658, 3254.381667483178, 3267.607887053554, 3291.045596776935, 5392.325959255093, 5468.562514998801, 5493.2034854946005, 5495.725213739312, 5503.697296648683, 5531.668099913998, 5630.183623374608, 5635.887282254363, 5641.435856414357, 5662.009148399024, 5043.117454445466, 5066.620003499734, 5092.490750924896, 5128.8974220515565, 5156.123459011958, 4859.052484765472, 5087.10975579274, 5135.794568217286, 5143.177091665316, 5147.48525147486, 4847.054824309261, 4980.053789779949, 5004.674696144739, 5037.395512538501, 5051.242313652945, 5008.198688209887, 5034.647574669756, 5048.899022019576, 5113.309703190096, 5138.794448222066, 4949.8020079196785, 4984.426790919055, 5029.974850125726, 5043.646944713872, 5043.949560504385, 5319.5478384337375, 5364.490373414519, 5435.0, 5455.1544510600925, 5501.559875209973, 5893.116032595102, 5906.675132867691, 5912.290525136968, 5990.2212712347555, 6011.669358185298, 6059.848503787441, 6065.120557519179, 6070.119832624289, 6074.088886666991, 6074.301455332649, 5416.214648875891, 5453.509184173404, 5551.9722401387735, 5555.583331250173, 5618.578606604521, 6107.206063211843, 6125.050617154348, 6140.324564297924, 6140.4473597376455, 6144.56988010835, 5867.559933005042, 5912.260967379078, 5913.822585322448, 5919.881602367928, 5922.1412895130825, 5752.453516915886, 5791.536677065909, 5830.5044071254415, 5872.0, 5873.794417195378, 5920.644761314335, 5925.73334199962, 5931.3178984417345, 5951.791687290924, 5965.254343207099, 5879.0, 5924.6149000314845, 5929.644221346647, 5937.465628093492, 5937.7921772737745, 4510.458744950627, 4553.54464553542, 4572.474165471013, 4591.288350305708, 4644.396228490275, 4132.586741325843, 4143.502779666459, 4177.5195852476745, 4181.393697913785, 4183.958160418357, 5741.511971482387, 5745.2818397700285, 5746.540276777848, 5752.165935939265, 5757.366689664133, 5830.737616807169, 5863.120531920246, 6000.0999850022845, 6002.249718785152, 6042.425969532887, 5639.238702775073, 5642.746076426571, 5688.601797874192, 5698.601097923106, 5742.626729262584, 5203.531682148625, 5215.739213039333, 5219.869503262373, 5220.034293655686, 5220.243064755665, 6056.515478761777, 6211.192544969215, 6226.688665566703, 6237.157983672237, 6275.3724627536885, 5829.650220986754, 5873.4126587340925, 5887.587868849139, 5922.940770592239, 5986.910196347146, 6195.654878928828, 6226.066090086523, 6232.345603711545, 6273.37266273369, 6281.340459251713, 5801.477866991991, 5804.6807425590305, 5856.238688970407, 5857.5313974881055, 5892.292924849045, 5673.801416950387, 5715.5713321500225, 5939.049752039653, 5981.820545383645, 5984.910226346521, 5897.764089436375, 5910.202122713378, 5918.644881306963, 5929.644221346561, 5933.0, 5826.854328641818, 5838.474537291664, 5842.5325973921135, 5858.297004359504, 5878.470937615635, 5529.861753456195, 5636.013697602985, 5772.769089236552, 5864.384239654775, 5885.911711324419, 5889.911651325319, 5948.791792287249, 5982.58121931478, 5983.311919129356, 5985.072313791369, 5527.723613819373, 5780.797672081625, 5787.479126878601, 5790.10253410722, 5804.361520232686], "value": 5498.719858673182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9867731469927, 606.2815563557185, 638.9680515974203, 645.2160624840817, 684.1892357556293, 32103.51844722328, 43227.35158972614, 43686.56313436865, 43877.0, 47160.52839471604, 45702.0, 46134.30798538025, 46156.76921615395, 46167.30749038767, 46186.53813461864, 8032.839343213132, 8992.685256016024, 9083.273338132933, 9140.862887056699, 9159.496227707474, 8148.674053037871, 10623.84064239037, 10842.241043126984, 10855.945720271387, 11156.0, 11069.612563560277, 11112.833307500394, 11145.777084458306, 11146.442677866115, 11158.386288754115, 10906.454677266145, 10966.287191332538, 10968.945155274172, 10969.780604387868, 10988.340699558012, 10700.30448020876, 10814.837777433344, 10821.080208182313, 10822.24244302899, 10822.404767737771, 42972.78513607412, 43440.0, 43478.56521434777, 43491.34762978558, 43500.56499434997, 3784.7539909906045, 3886.300465916134, 3890.6498415142773, 3956.4460975463458, 4167.124903770212, 33005.33989320224, 33034.339313213844, 33089.50365744516, 33123.52439091344, 34248.31503369944, 4216.241076606209, 4234.788260586958, 4250.128723611652, 4250.957490425087, 4268.87193384199, 251241.0, 251306.0, 251582.0, 251739.0, 252923.0, 61058.0, 61405.0, 61439.692801535704, 61530.0, 61609.0, 39690.20619587592, 40320.79839600842, 40507.18985620271, 43040.13919721588, 43060.0, 18790.0, 18935.0, 18948.05259737035, 18959.0, 18972.14625341863, 12981.675458113623, 13345.266010369329, 14056.859431405555, 14414.711705765825, 14507.637309067146, 19426.84317516987, 20343.593128137356, 20434.284800031928, 20435.4891127723, 20587.485312867, 7585.0, 7658.578778167142, 7667.501612395176, 7721.420893433015, 7728.884066739003, 981.788915383196, 1055.672741450153, 1062.9681109566725, 1094.9616763413242, 1150.1546363422879, 34364.31271374559, 34426.48360274598, 34621.480677789856, 34774.30451390958, 34795.0, 1065.8454524093963, 1159.565163063851, 1170.2568868768394, 1194.7729931313022, 1272.2620879889641, 15455.38178472871, 18082.457526274233, 18258.543536411697, 18566.164522596246, 18626.250306171838, 559415.0, 559444.0, 562841.0, 563215.0, 564886.0, 62195.06707399392, 62537.0, 62610.373896260455, 62686.373136268056, 62766.37233627605, 1317.4730107956702, 1393.2058726525784, 1439.6256973187046, 1474.108164560447, 1493.2682985337105, 29979.70020299769, 33607.0, 33703.4944475838, 34539.82730086333, 34856.302873942885, 51050.74474627603, 51592.0, 51701.741491292305, 51762.741186293824, 51835.481645184576, 432580.0, 434702.0, 436964.0, 437546.0, 439100.0, 29878.850605746833, 30860.537091943188, 31180.220494487818, 32934.67065329412, 32959.0, 49805.75097124491, 49915.75042124766, 51120.0, 51397.74301128471, 51656.74171629118, 43027.3545896818, 43132.13735725205, 43481.34777978269, 43931.560684394026, 44096.0, 43357.34963975606, 43705.34441983309, 44065.0, 44330.0, 44708.55291447044, 44289.0, 45136.54863451324, 45520.77239613781, 45707.0, 45817.0, 36080.27839443249, 38267.6173238264, 38443.0, 38716.80641596774, 39284.214315714096, 29834.657440415667, 30091.548626771055, 30168.832272611937, 30249.546256805726, 30430.543541846448], "value": 21046.9943631787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.5234594465365, 422.2989836870795, 424.4502645579205, 428.89492074441756, 439.3300217168818, 15108.320125594348, 19305.903470482644, 19584.314548990787, 19881.90059049706, 20148.294809681665, 14098.859011409908, 14847.55457336279, 20255.797442025574, 20335.389938301836, 20400.693989590167, 5188.247704082905, 5441.156620723794, 5452.236686863842, 5456.372517160537, 5463.071277882769, 4040.474738284019, 4240.406343111967, 5232.581393488512, 5782.826515204551, 5969.492593129589, 6056.818295451144, 6059.7273122709585, 6076.908846367308, 6081.422264884829, 6099.451049405553, 6075.2405949256345, 6545.770898018571, 6568.0, 6569.37590928861, 6573.014047892831, 5280.18157185633, 5531.9723401383135, 5928.0, 5934.673592952386, 5934.910976335358, 13424.463021479129, 13585.388657510337, 13650.385732642055, 13897.79153312701, 13967.022308438414, 2349.8237632177484, 2393.6050551658955, 2431.5744744669614, 2669.599560065986, 2715.2940235538704, 10992.670219893416, 11081.944590277079, 11106.61126860564, 14741.705165896621, 15262.38950441981, 1900.4773687235981, 1979.1885327015998, 2071.2336435518955, 2101.548167144056, 2102.568973360457, 84412.57793710992, 84896.57551712263, 86656.0, 87397.0, 89065.55467222688, 10612.840807387895, 11443.942780286212, 11769.411529423494, 12071.517139314328, 12101.394930253453, 15196.316165772567, 15514.767278490832, 16214.108224047555, 16272.18639068042, 16804.0, 8785.868211976698, 8828.249598784047, 8925.419847709878, 8979.820403591892, 9042.231410330063, 8555.657773688983, 8603.78490537729, 8636.136386361313, 8756.824863502694, 8808.735737927873, 4901.779419926112, 4956.5786908112495, 5061.114304996611, 5125.923111153335, 5266.8419947401635, 2119.5337025854287, 2134.6371116910163, 2143.2498625480957, 2147.946301342479, 2150.2689085710936, 930.2232635749225, 986.659602437158, 1057.471264367816, 1060.2101434431397, 1101.9338839669645, 20431.693524597144, 20523.4869128273, 20737.897672753523, 21030.263940762, 21182.364529064154, 1008.4503945349802, 1062.5377960587168, 1062.8830828608848, 1093.8742044664807, 1128.2414496556005, 10361.792764144826, 11464.828027579593, 11533.942330288462, 11606.129540284512, 11717.472713727731, 506319.0, 510610.0, 515952.0, 516078.0, 524223.0, 93490.0, 96194.51902740581, 96504.0, 98038.50980745051, 98420.50789746005, 938.8403971324891, 959.4579062829479, 981.9361741486781, 985.113397941858, 1008.5612758450097, 17637.559061023578, 17869.28522859071, 17912.820871791115, 17956.371526996492, 18381.81618183801, 43520.0, 43933.901652458946, 43976.120477589626, 44018.559814401444, 44647.77676111729, 58697.70651146717, 58846.0, 59163.70418148054, 59672.40327596669, 60093.0, 5746.885062298814, 6695.631740254333, 8693.739187824376, 8986.652002199722, 9011.0, 11868.40657967081, 13018.414171362121, 13227.603171904859, 13431.731365372832, 14150.716985660434, 11899.107566932687, 12151.635450936486, 12261.69345766363, 12270.141090123605, 12345.0, 5544.0575102231915, 8990.0, 11612.187146899636, 11669.714502703177, 12225.205361651464, 12138.239955206622, 12169.878301217228, 12222.083343749433, 12246.510139594317, 12748.553800616934, 7708.537487750753, 8320.583970801315, 9064.501452419916, 9079.954600226956, 9375.0, 10399.740006499898, 12292.262464252173, 12428.689282768004, 12471.674527244544, 12684.175528590613], "value": 9377.870552087705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.1182925184007, 1480.5928369698331, 1509.3208056374633, 1636.1492024147444, 1850.7964123946356, 7825.5304681719135, 8282.585870706464, 8681.131886811316, 9005.189532942033, 9016.143466370684, 9050.411723238001, 9132.178103970642, 9141.725748227547, 9146.22257108145, 9148.039455857139, 2461.8769061546896, 2479.47930934504, 2484.8757562121823, 2486.4405508760565, 2493.289412517433, 2441.340837973746, 2498.8625625590585, 2499.2252401755422, 2501.687289088864, 2502.5620516409645, 2466.8643224622638, 2468.543319485892, 2470.0737223541173, 2470.493548822496, 2482.491089326693, 2355.8468699534474, 2361.988190059056, 2379.1078345620394, 2399.868007259609, 2438.926832195028, 2471.9011239550396, 2485.192312498445, 2489.3154382544762, 2509.0716434919013, 2510.472800711853, 8809.42738721981, 8812.250958668521, 8983.416077954913, 9089.954550227207, 9095.135962083592, 5411.107167317388, 5550.4449555044575, 5561.165825126223, 5561.360443549003, 5564.10974244119, 3500.9824950875336, 3632.473291372736, 3650.7627004244905, 3709.8330575124182, 3724.9068773280615, 1124.1063354633086, 1128.836318733779, 1159.7100724818795, 1164.551647615674, 1173.2960223865698, 11947.044236461063, 11952.940235298855, 12038.879611203864, 12044.156909016372, 12110.515579376903, 4431.246688063037, 4674.719516829001, 4754.429468463806, 4773.069251495925, 4794.2808578712775, 10078.0, 10118.645847395306, 10123.848142277871, 10124.797504049879, 10130.645427410005, 5351.785928562892, 5390.110631745718, 5396.64921780083, 5410.48600382963, 5414.431484694129, 4230.323148296257, 4361.956380436219, 5021.623378246646, 5021.698698078127, 5076.466970968069, 4049.635532802062, 4079.97960010204, 4161.0, 4192.496900371914, 4202.117555313357, 1239.324568110382, 1262.5770366927181, 1264.1214356022476, 1268.1566758105942, 1275.324078238535, 932.9626814927462, 1002.7092143278368, 1034.110664828247, 1040.7450174707094, 1065.1053115383115, 6049.727762250709, 6068.939310606837, 6200.627962322184, 6318.6524741138755, 6326.841828954313, 470.2569939495589, 478.4234996828813, 485.8153901517401, 490.07620635102376, 511.53194826733863, 4253.680973926967, 4391.978040109779, 4453.287474004209, 4459.710118842329, 4513.5486451355255, 10855.2401331906, 11274.098072154207, 11280.097592192606, 11297.096232301396, 11375.03312218454, 11285.71785705364, 11293.096552275798, 11293.15301352402, 11304.547818087185, 11305.321680699184, 8092.635831387602, 8427.410081294373, 8434.74695759116, 8533.232009119209, 8636.0, 6219.813405597839, 6338.619682819046, 6428.903566446414, 6429.32492088324, 6535.934640653532, 10234.590616375262, 10461.26771126014, 10478.895211047791, 10486.842697359392, 10577.788444231226, 10279.177665786869, 10448.68653940383, 10498.737531561466, 10530.684079477627, 10624.990625890528, 7961.243681850215, 7990.3208227299, 7994.600269986594, 8039.718609848627, 8067.193280672121, 8401.831963360577, 8409.032961209294, 8446.83106337882, 8449.112843151626, 8470.915290847013, 7366.263373662591, 7383.852322953619, 7500.399968002655, 7633.923660763321, 7669.34810541088, 7168.068151140318, 7341.3392794648735, 7365.2634736525915, 7409.444291678254, 7494.737684181027, 7330.706771729071, 7488.8876666848955, 7493.288137626917, 7542.170361260147, 7543.057117860268, 5462.535684466865, 5464.836054918359, 5537.5569954402745, 5547.694876781816, 5700.714964251853, 5511.338639363142, 5538.639988400902, 5613.803516876889, 5622.128570071645, 5687.43125687428], "value": 4697.4068179951155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.82208895552225, 356.4617427684197, 359.34060998068543, 359.73918908791114, 362.53052297275025, 5316.0, 5337.5196232339085, 5345.572354211668, 5359.946400535999, 5384.246205531229, 5279.4984476474765, 5309.203619457084, 5331.680099194051, 5337.973310133453, 5347.572194224463, 3741.7567858089137, 3978.860739874105, 4116.217918595457, 4191.245575796355, 4212.0, 4192.706510544263, 4203.558626344236, 4211.768352740598, 4211.789410529476, 4225.535191128974, 4192.580741925798, 4193.077522944947, 4203.243416185085, 4209.779164042439, 4218.240716670998, 3986.641202291793, 4106.77412742299, 4113.424120623115, 4152.294110001307, 4234.640055595262, 3728.608496107897, 3742.0, 3744.887653370376, 3745.4943582616543, 3755.793431361274, 5125.3080834087295, 5135.281060651511, 5154.994776018678, 5186.896262074737, 5196.29849970253, 4703.836235331752, 4762.880927976794, 4793.3049707792525, 4811.326414302001, 4817.494163112858, 5499.0, 5513.696746678931, 5517.751701173457, 5523.364813046511, 5531.723413829292, 4143.6892233082635, 4144.336906095041, 4150.568054021358, 4161.417401563784, 4168.687348448848, 5649.802256920988, 5703.4011428799795, 5725.599208055438, 5732.914006289867, 5792.1890935268675, 4209.842293369286, 4214.241436541452, 4215.7352794161625, 4232.280512312914, 4259.041715613962, 4276.422682937764, 4296.699231053796, 4311.504177019683, 4315.352697095461, 4317.41714868495, 4622.695494240304, 4747.833825816149, 4801.591864691541, 4801.927971080437, 4831.541003604652, 5521.751521181556, 5531.917021244684, 5544.584156188222, 5556.222128901957, 5568.276124103841, 1436.1670231265841, 1437.058726534122, 1451.7894905238682, 1453.7019910918236, 1454.7817827325773, 968.941863488193, 1015.8323876560432, 1018.8487009679016, 1021.2646894236138, 1034.637876743149, 5232.869178270574, 5249.737513124405, 5262.368515778131, 5273.78904843802, 5317.601179911522, 5487.945120548743, 5517.779288828482, 5521.944780552223, 5525.0, 5543.750531226105, 4967.105920934267, 5200.401953775288, 5237.973810130925, 5254.4220135785035, 5347.893042139135, 2858.44260369226, 2884.841333726665, 2886.292858249742, 2889.3787835615444, 2908.7672986161056, 5621.831345059655, 5651.463111004448, 5664.858378540487, 5670.914936275959, 5699.686517241592, 5246.97376513115, 5488.012157811552, 5496.47162305336, 5508.889822203533, 5520.861978450571, 5633.6619802811965, 5763.109900816932, 5922.489765109869, 5926.844265368211, 5930.851728706731, 5639.661620302795, 5650.29371328584, 5655.943440565542, 5659.349174844946, 5661.943380566142, 5488.725563721878, 5578.410153106345, 5592.5525957922455, 5611.1022236443605, 5622.5501959842295, 5900.0, 5901.7639294427745, 5920.526357891445, 5922.200502932222, 5942.168096466412, 4154.106867023484, 4168.7707176105605, 4178.8328466860985, 4192.790360482025, 4197.181549597921, 5575.665460072409, 5667.688277144632, 5674.631148975303, 5679.545636349165, 5706.172604972338, 5514.80698175562, 5551.333839939233, 5553.9444605555045, 5600.955651187206, 5611.579131565068, 5285.810692594136, 5517.282753242052, 5529.534673311495, 5532.723363831712, 5537.363203231519, 5484.533814625802, 5499.800079968045, 5548.195511650707, 5548.472895074961, 5552.916706249329, 5528.585356098229, 5574.693391863487, 5576.888462230651, 5583.497485226349, 5598.972005139948, 5285.260063591178, 5390.865228369322, 5442.482964118402, 5459.426760190282, 5467.835964921059], "value": 4259.251311462912, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.0539926385023, 823.3001948343908, 825.8967629046373, 861.7285555050158, 877.3810176622776, 14261.714765704679, 14804.0, 14975.925120374382, 14986.550403487885, 15001.324940377683, 14226.92886535566, 14472.927635361808, 14596.197209153492, 14645.26773661318, 14654.706905861876, 710.7050574011805, 726.2664708644281, 834.0825092398344, 848.3637272045966, 852.5098068610542, 835.3359079531787, 857.3098655582254, 857.5797859049052, 867.1588559097665, 867.8351113288455, 900.572228191607, 910.1217325281102, 910.4355299714153, 912.2473958983832, 912.6851236323457, 748.5321673953779, 763.3435245688703, 907.2016625369665, 907.2333877873186, 907.2379201470764, 640.5580149696741, 657.4904449051975, 660.5046215338496, 666.2804171494774, 666.5534092158266, 14166.92916535421, 14193.716125677533, 14197.929010354883, 14227.0, 14265.857341426557, 13926.860731392657, 13977.0, 14205.36075876588, 14302.64243393913, 14327.856721432756, 12064.758704825943, 12190.268583884996, 12225.266484010988, 12325.938370308091, 12529.310887901162, 4419.138268037734, 4420.557944205586, 4465.022007173453, 4535.365048893158, 4541.954580454186, 61875.0, 62021.0, 62148.68925655388, 63337.366626333605, 64902.3509764901, 11275.210735248455, 11334.0, 11419.200655954004, 11575.073994080454, 11690.415479226005, 20233.291834785712, 20348.18607255693, 20349.49126271855, 20371.388858334274, 20375.796242037686, 8044.0, 8058.758237252891, 8152.103268640445, 8323.5005899645, 8676.566171691517, 4630.490646028934, 4883.145449546315, 4902.656814023056, 5054.721990290495, 5076.8476945690945, 3387.796732196076, 3494.3710132175943, 3495.8252087395526, 3497.4753786932165, 3497.89506314811, 627.4133685004444, 635.1140159477595, 638.0939066525544, 640.6092283706935, 640.7725257533508, 713.4435140590348, 723.1430754555763, 729.2525161709184, 733.5561984998999, 771.7260372567657, 9553.522323883779, 9575.760605984768, 9606.087421695067, 9620.567074481665, 10146.82005729806, 631.6810010944444, 724.7101159536122, 730.1092666946317, 740.2634378793027, 751.1136858507015, 4442.6890117691455, 4605.746683932349, 4613.907721845544, 4685.695429797052, 4746.38297021385, 55340.16989745157, 68305.0, 87760.5611971936, 93531.53234233786, 93923.53038234766, 63335.36664633295, 76527.0, 76758.61620691861, 77758.6112069436, 79589.60205199053, 65891.0, 66024.33975660182, 66247.66876165588, 66612.666936665, 67807.66096169487, 9934.403935763878, 10269.155675977161, 10324.122449591869, 10584.523696433833, 10631.627893023708, 33973.66026339804, 34710.78512252059, 43449.782751086044, 44647.55352446434, 45105.774471127435, 54906.45093549173, 58061.02274194937, 60413.0, 63420.0, 64444.0, 13186.340682966005, 13443.395047222702, 13507.257100859548, 13631.318434078456, 14045.0, 14227.217503037433, 14296.499622513162, 15056.171910545025, 15296.923515382798, 15829.762553561475, 11572.18994670365, 12552.184108032949, 13523.323833808467, 13689.383977721225, 14407.639809004439, 13194.472221111047, 13527.458901643824, 13954.302284885918, 14056.718865622835, 14212.21832799206, 13434.529791457253, 14122.293885305487, 14209.147451152963, 14330.0, 14909.403623855358, 11433.714157145805, 11925.522979081086, 12003.840432993882, 12063.81904271419, 12432.440540175894, 11820.468078936641, 11845.940770296093, 12051.216670916363, 12286.385680716106, 12303.692407689521], "value": 7360.499344175914, "unit": "score"}], "name": "dromaeo_css", "value": 7366.876266952492, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 110.0, 111.0, 110.0, 109.0, 110.0, 111.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 118.0, 151.0, 119.0, 120.0, 118.0, 128.0, 155.0, 119.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 159.0, 162.0, 160.0, 160.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 122.0, 75.0, 76.0, 76.0, 76.0, 98.0, 84.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 121.0, 82.0, 82.0, 82.0, 99.0, 82.0, 82.0, 114.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 86.0, 84.0, 84.0, 84.0, 83.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 52.0, 52.0, 51.0, 52.0, 53.0, 52.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0, 60.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 83.0, 75.0, 75.0, 75.0, 74.0, 83.0, 82.0, 77.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 122.0, 122.0, 128.0, 128.0, 127.0, 120.0, 164.0, 120.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 155.0, 154.0, 159.0, 157.0, 156.0, 152.0, 153.0, 155.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 62.0, 64.0, 63.0, 73.0, 63.0, 62.0, 61.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1454.1999999999998, "alertThreshold": 2.0}]} 18:02:52 INFO - Return code: 0 18:02:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:02:52 INFO - # TBPL SUCCESS # 18:02:52 INFO - Running post-action listener: _resource_record_post_action 18:02:52 INFO - [mozharness: 2017-01-06 02:02:52.832511Z] Finished run-tests step (success) 18:02:52 INFO - Running post-run listener: _resource_record_post_run 18:02:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355655680; Read time: 12; Write time: 221908 18:02:52 INFO - TinderboxPrint: CPU usage
13.0% 18:02:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:02:52 INFO - TinderboxPrint: I/O write bytes / time
355,655,680 / 221,908 18:02:52 INFO - TinderboxPrint: CPU idle
8,277.5 (87.0%) 18:02:52 INFO - TinderboxPrint: CPU user
1,190.9 (12.5%) 18:02:52 INFO - TinderboxPrint: Swap in / out
0 / 0 18:02:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108163072; Read time: 0; Write time: 94036 18:02:52 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 247492608; Read time: 0; Write time: 127872 18:02:53 INFO - Running post-run listener: _upload_blobber_files 18:02:53 INFO - Blob upload gear active. 18:02:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:53 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 18:02:53 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'] 18:02:53 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 18:02:53 INFO - (blobuploader) - INFO - Open directory for files ... 18:02:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:02:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:02:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:54 INFO - (blobuploader) - INFO - Done attempting. 18:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:55 INFO - (blobuploader) - INFO - Done attempting. 18:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:02:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:59 INFO - (blobuploader) - INFO - Done attempting. 18:02:59 INFO - (blobuploader) - INFO - Iteration through files over. 18:02:59 INFO - Return code: 0 18:02:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:02:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:02:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4f448e06ff63019989a14212f4a5072b95319096878439b2a1ec91f3656db3225b3e876b88001e97b3e53849dd521cc56d9c5b2242109ab8d7f172544054b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1deb04bea2dc9a04b089076e2e43b9a43355d90756844e35867ed67ce3a153aa1f5b283bc5307c955cbfb0543434cb091b8f8cb9a9c6240881124577bb442acc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/358fad47bcfac6dbbde8973c3adebb48f5bdef33aa8f182eb40027e548ed9cb2272c6a3795c4fa6f58fbbd82cd99aed5a3ea4d9b9e0712eeff289cffbcb1802e"} 18:02:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:59 INFO - Contents: 18:02:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4f448e06ff63019989a14212f4a5072b95319096878439b2a1ec91f3656db3225b3e876b88001e97b3e53849dd521cc56d9c5b2242109ab8d7f172544054b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1deb04bea2dc9a04b089076e2e43b9a43355d90756844e35867ed67ce3a153aa1f5b283bc5307c955cbfb0543434cb091b8f8cb9a9c6240881124577bb442acc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/358fad47bcfac6dbbde8973c3adebb48f5bdef33aa8f182eb40027e548ed9cb2272c6a3795c4fa6f58fbbd82cd99aed5a3ea4d9b9e0712eeff289cffbcb1802e"} 18:02:59 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:59 INFO - Copying logs to upload dir... 18:02:59 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.301584 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-05 18:02:58.597439) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 18:02:58.600873) ========= 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=7de08804244eb36560b44971000001c3-1483666939.510170-472616284 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/c4f448e06ff63019989a14212f4a5072b95319096878439b2a1ec91f3656db3225b3e876b88001e97b3e53849dd521cc56d9c5b2242109ab8d7f172544054b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1deb04bea2dc9a04b089076e2e43b9a43355d90756844e35867ed67ce3a153aa1f5b283bc5307c955cbfb0543434cb091b8f8cb9a9c6240881124577bb442acc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/358fad47bcfac6dbbde8973c3adebb48f5bdef33aa8f182eb40027e548ed9cb2272c6a3795c4fa6f58fbbd82cd99aed5a3ea4d9b9e0712eeff289cffbcb1802e"} build_url:https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011528 build_url: 'https://queue.taskcluster.net/v1/task/LfpgsBSiQ_2wlNVfGjX3vQ/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/c4f448e06ff63019989a14212f4a5072b95319096878439b2a1ec91f3656db3225b3e876b88001e97b3e53849dd521cc56d9c5b2242109ab8d7f172544054b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1deb04bea2dc9a04b089076e2e43b9a43355d90756844e35867ed67ce3a153aa1f5b283bc5307c955cbfb0543434cb091b8f8cb9a9c6240881124577bb442acc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/358fad47bcfac6dbbde8973c3adebb48f5bdef33aa8f182eb40027e548ed9cb2272c6a3795c4fa6f58fbbd82cd99aed5a3ea4d9b9e0712eeff289cffbcb1802e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 18:02:58.626704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 18:02:58.627027) ========= 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=7de08804244eb36560b44971000001c3-1483666939.510170-472616284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 18:02:58.711409) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 18:02:58.711748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 18:02:58.712037) ========= ========= Total master_lag: 0.19 =========