builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1483093660.29 results: success (0) buildid: 20161230004019 builduid: 1b9bbea94c0e42749c18886597f0541f revision: b213de949cddebe0a123654be580ba114b951020 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:40.287930) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:40.288409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:40.288786) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:40.303990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:40.304310) ========= 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=62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 02:27:40-- 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% 70.1M=0s 2016-12-30 02:27:40 (70.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112749 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:40.431158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:40.431470) ========= 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=62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017022 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:40.481402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:40.481770) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b213de949cddebe0a123654be580ba114b951020 --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 b213de949cddebe0a123654be580ba114b951020 --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=62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 02:27:40,748 truncating revision to first 12 chars 2016-12-30 02:27:40,748 Setting DEBUG logging. 2016-12-30 02:27:40,748 attempt 1/10 2016-12-30 02:27:40,748 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b213de949cdd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 02:27:41,200 unpacking tar archive at: mozilla-aurora-b213de949cdd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.752846 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:41.249074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:41.249541) ========= script_repo_revision: b213de949cddebe0a123654be580ba114b951020 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:41.250234) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:41.250853) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 02:27:41.262122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-30 02:27:41.263077) ========= /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=62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:27:41 INFO - MultiFileLogger online at 20161230 02:27:41 in /builds/slave/test 02:27:41 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 02:27:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:27:41 INFO - {'append_to_log': False, 02:27:41 INFO - 'base_work_dir': '/builds/slave/test', 02:27:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:27:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:27:41 INFO - 'branch': 'Mozilla-Aurora', 02:27:41 INFO - 'buildbot_json_path': 'buildprops.json', 02:27:41 INFO - 'config_files': ('talos/linux_config.py',), 02:27:41 INFO - 'default_actions': ('clobber', 02:27:41 INFO - 'read-buildbot-config', 02:27:41 INFO - 'download-and-extract', 02:27:41 INFO - 'populate-webroot', 02:27:41 INFO - 'create-virtualenv', 02:27:41 INFO - 'install', 02:27:41 INFO - 'run-tests'), 02:27:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:27:41 INFO - 'download_minidump_stackwalk': True, 02:27:41 INFO - 'download_symbols': 'ondemand', 02:27:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:27:41 INFO - 'tooltool.py': '/tools/tooltool.py', 02:27:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:27:41 INFO - '/tools/misc-python/virtualenv.py')}, 02:27:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:27:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:27:41 INFO - 'installer_path': 'installer.exe', 02:27:41 INFO - 'log_level': 'info', 02:27:41 INFO - 'log_name': 'talos', 02:27:41 INFO - 'log_to_console': True, 02:27:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:27:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:27:41 INFO - 'opt_config_files': (), 02:27:41 INFO - 'pip_index': False, 02:27:41 INFO - 'sps_profile': False, 02:27:41 INFO - 'sps_profile_interval': 0, 02:27:41 INFO - 'suite': 'dromaeojs', 02:27:41 INFO - 'system_bits': '32', 02:27:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:27:41 INFO - 'title': 'talos-linux64-ix-018', 02:27:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:27:41 INFO - 'use_talos_json': True, 02:27:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:27:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:27:41 INFO - 'work_dir': 'build'} 02:27:41 INFO - [mozharness: 2016-12-30 10:27:41.632152Z] Running clobber step. 02:27:41 INFO - Running pre-action listener: _resource_record_pre_action 02:27:41 INFO - Running main action method: clobber 02:27:41 INFO - rmtree: /builds/slave/test/build 02:27:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:27:42 INFO - Running post-action listener: _resource_record_post_action 02:27:42 INFO - [mozharness: 2016-12-30 10:27:42.095180Z] Finished clobber step (success) 02:27:42 INFO - [mozharness: 2016-12-30 10:27:42.095279Z] Running read-buildbot-config step. 02:27:42 INFO - Running pre-action listener: _resource_record_pre_action 02:27:42 INFO - Running main action method: read_buildbot_config 02:27:42 INFO - Using buildbot properties: 02:27:42 INFO - { 02:27:42 INFO - "project": "", 02:27:42 INFO - "product": "firefox", 02:27:42 INFO - "script_repo_revision": "production", 02:27:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:27:42 INFO - "repository": "", 02:27:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:27:42 INFO - "buildid": "20161230004019", 02:27:42 INFO - "stage_platform": "linux64-pgo", 02:27:42 INFO - "basedir": "/builds/slave/test", 02:27:42 INFO - "nightly_build": "True", 02:27:42 INFO - "buildnumber": 667, 02:27:42 INFO - "slavename": "talos-linux64-ix-018", 02:27:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:27:42 INFO - "platform": "ubuntu64_hw", 02:27:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:27:42 INFO - "branch": "mozilla-aurora", 02:27:42 INFO - "repo_path": "releases/mozilla-aurora", 02:27:42 INFO - "revision": "b213de949cddebe0a123654be580ba114b951020", 02:27:42 INFO - "pgo_build": "True", 02:27:42 INFO - "builduid": "1b9bbea94c0e42749c18886597f0541f", 02:27:42 INFO - "slavebuilddir": "test" 02:27:42 INFO - } 02:27:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:27:42 INFO - Running post-action listener: _resource_record_post_action 02:27:42 INFO - [mozharness: 2016-12-30 10:27:42.097915Z] Finished read-buildbot-config step (success) 02:27:42 INFO - [mozharness: 2016-12-30 10:27:42.098003Z] Running download-and-extract step. 02:27:42 INFO - Running pre-action listener: _resource_record_pre_action 02:27:42 INFO - Running main action method: download_and_extract 02:27:42 INFO - mkdir: /builds/slave/test/build/tests 02:27:42 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')]} 02:27:42 INFO - trying https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:27:42 INFO - Downloading https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/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 02:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/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 02:27:42 INFO - Downloaded 1361 bytes. 02:27:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:27:42 INFO - Using the following test package requirements: 02:27:42 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:27:42 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:27:42 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:27:42 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:42 INFO - u'jsshell-linux-x86_64.zip'], 02:27:42 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:27:42 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:27:42 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:27:42 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:27:42 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:27:42 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:42 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:27:42 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:27:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:27:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:27:42 INFO - Fetch https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:27:43 INFO - Http code: 200 02:27:43 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 02:27:43 INFO - x-amz-cf-id: vr-1fRuqFbqrrTvCr_xy6k6CSNe4yv-mSDUcvm8wur2YBaSrXkni9A== 02:27:43 INFO - x-amz-version-id: hy7OqLPYRoxnVQg9PrpRnBYKyqhVlVcj 02:27:43 INFO - Expected file size: 21940996 02:27:43 INFO - Obtained file size: 21940996 02:27:47 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 02:27:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:27:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:27:47 INFO - Fetch https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:27:48 INFO - Http code: 200 02:27:48 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 02:27:48 INFO - x-amz-cf-id: 2VEz-9Qr2nodRNzREuKgLkfK9MsWPwdUzhYjDs93UWSc8HMUymupBQ== 02:27:48 INFO - x-amz-version-id: hy7OqLPYRoxnVQg9PrpRnBYKyqhVlVcj 02:27:48 INFO - Expected file size: 21940996 02:27:48 INFO - Obtained file size: 21940996 02:27:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:27:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:27:52 INFO - Fetch https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:27:53 INFO - Http code: 200 02:27:53 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 02:27:53 INFO - x-amz-cf-id: CvORPbQpw_TUa9xOPTrsup5oll5py-_LTpPi1vePiGV_OWaa0gljjw== 02:27:53 INFO - x-amz-version-id: y3T1xHS18ai3q02FVzlvOcoflaLGX5qv 02:27:53 INFO - Expected file size: 14409038 02:27:53 INFO - Obtained file size: 14409038 02:27:53 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')]} 02:27:53 INFO - trying https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/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 02:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/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 02:27:54 INFO - Downloaded 63987778 bytes. 02:27:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:27:54 INFO - mkdir: /builds/slave/test/properties 02:27:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:27:54 INFO - Writing to file /builds/slave/test/properties/build_url 02:27:54 INFO - Contents: 02:27:54 INFO - build_url:https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:27:55 INFO - Running post-action listener: _resource_record_post_action 02:27:55 INFO - Running post-action listener: set_extra_try_arguments 02:27:55 INFO - [mozharness: 2016-12-30 10:27:55.579106Z] Finished download-and-extract step (success) 02:27:55 INFO - [mozharness: 2016-12-30 10:27:55.579331Z] Running populate-webroot step. 02:27:55 INFO - Running pre-action listener: _resource_record_pre_action 02:27:55 INFO - Running main action method: populate_webroot 02:27:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:27:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:27:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:27:55 INFO - '--tppagecycles', 02:27:55 INFO - '7'], 02:27:55 INFO - 'tests': ['tsvgm']}}, 02:27:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:27:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:27:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:27:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:27:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:55 INFO - 'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:55 INFO - 'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['damp', 'tps']}, 02:27:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:55 INFO - 'tests': ['damp', 'tps']}, 02:27:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['dromaeo_dom']}, 02:27:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:27:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['basic_compositor_video']}, 02:27:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:27:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['a11yr', 02:27:55 INFO - 'ts_paint', 02:27:55 INFO - 'tpaint', 02:27:55 INFO - 'sessionrestore', 02:27:55 INFO - 'sessionrestore_no_auto_restore', 02:27:55 INFO - 'tabpaint']}, 02:27:55 INFO - 'other-e10s': {'tests': ['a11yr', 02:27:55 INFO - 'ts_paint', 02:27:55 INFO - 'tpaint', 02:27:55 INFO - 'sessionrestore', 02:27:55 INFO - 'sessionrestore_no_auto_restore', 02:27:55 INFO - 'tabpaint']}, 02:27:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:27:55 INFO - 'ts_paint', 02:27:55 INFO - 'tpaint', 02:27:55 INFO - 'sessionrestore', 02:27:55 INFO - 'sessionrestore_no_auto_restore', 02:27:55 INFO - 'tabpaint']}, 02:27:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:27:55 INFO - 'ts_paint', 02:27:55 INFO - 'tpaint', 02:27:55 INFO - 'sessionrestore', 02:27:55 INFO - 'sessionrestore_no_auto_restore', 02:27:55 INFO - 'tabpaint']}, 02:27:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['a11yr', 02:27:55 INFO - 'ts_paint', 02:27:55 INFO - 'tpaint', 02:27:55 INFO - 'sessionrestore', 02:27:55 INFO - 'sessionrestore_no_auto_restore', 02:27:55 INFO - 'tabpaint']}, 02:27:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['a11yr', 02:27:55 INFO - 'ts_paint', 02:27:55 INFO - 'tpaint', 02:27:55 INFO - 'sessionrestore', 02:27:55 INFO - 'sessionrestore_no_auto_restore', 02:27:55 INFO - 'tabpaint']}, 02:27:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['tsvgx', 02:27:55 INFO - 'tsvgr_opacity', 02:27:55 INFO - 'tart', 02:27:55 INFO - 'tscrollx', 02:27:55 INFO - 'cart']}, 02:27:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:27:55 INFO - 'tsvgr_opacity', 02:27:55 INFO - 'tart', 02:27:55 INFO - 'tscrollx', 02:27:55 INFO - 'cart']}, 02:27:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:55 INFO - 'talos_options': ['--disable-e10s'], 02:27:55 INFO - 'tests': ['tp5o']}, 02:27:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:55 INFO - 'tests': ['tp5o']}, 02:27:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:55 INFO - 'talos_options': ['--disable-e10s', 02:27:55 INFO - '--xperf_path', 02:27:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:55 INFO - 'tests': ['tp5n']}, 02:27:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:55 INFO - 'talos_options': ['--xperf_path', 02:27:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:55 INFO - 'tests': ['tp5n']}}, 02:27:55 INFO - 'talos.zip': {'path': '', 02:27:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:27:55 INFO - Running post-action listener: _resource_record_post_action 02:27:55 INFO - [mozharness: 2016-12-30 10:27:55.601422Z] Finished populate-webroot step (success) 02:27:55 INFO - [mozharness: 2016-12-30 10:27:55.601510Z] Running create-virtualenv step. 02:27:55 INFO - Running pre-action listener: _resource_record_pre_action 02:27:55 INFO - Running main action method: create_virtualenv 02:27:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:27:55 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 02:27:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:27:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:27:55 INFO - Using real prefix '/usr' 02:27:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:27:56 INFO - Installing distribute.............................................................................................................................................................................................done. 02:27:58 INFO - Installing pip.................done. 02:27:58 INFO - Return code: 0 02:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:27:58 INFO - Reading from file tmpfile_stdout 02:27:58 INFO - Output received: 02:27:58 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) 02:27:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:27:58 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')]} 02:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:58 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')]} 02:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:58 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:27:58 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 02:27:58 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 02:27:58 INFO - Using env: {'DISPLAY': ':0', 02:27:58 INFO - 'HOME': '/home/cltbld', 02:27:58 INFO - 'LANG': 'en_US.UTF-8', 02:27:58 INFO - 'LANGUAGE': 'en_US:en', 02:27:58 INFO - 'LOGNAME': 'cltbld', 02:27:58 INFO - 'MAIL': '/var/mail/cltbld', 02:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:58 INFO - 'MOZ_NO_REMOTE': '1', 02:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:58 INFO - 'NO_EM_RESTART': '1', 02:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:58 INFO - 'PWD': '/builds/slave/test', 02:27:58 INFO - 'SHELL': '/bin/bash', 02:27:58 INFO - 'SHLVL': '1', 02:27:58 INFO - 'TERM': 'linux', 02:27:58 INFO - 'TMOUT': '86400', 02:27:58 INFO - 'USER': 'cltbld', 02:27:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:58 INFO - '_': '/tools/buildbot/bin/python'} 02:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:58 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 02:27:58 INFO - Cleaning up... 02:27:58 INFO - Return code: 0 02:27:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:27:58 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')]} 02:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:58 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')]} 02:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:58 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:27:58 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 02:27:58 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 02:27:58 INFO - Using env: {'DISPLAY': ':0', 02:27:58 INFO - 'HOME': '/home/cltbld', 02:27:58 INFO - 'LANG': 'en_US.UTF-8', 02:27:58 INFO - 'LANGUAGE': 'en_US:en', 02:27:58 INFO - 'LOGNAME': 'cltbld', 02:27:58 INFO - 'MAIL': '/var/mail/cltbld', 02:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:58 INFO - 'MOZ_NO_REMOTE': '1', 02:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:58 INFO - 'NO_EM_RESTART': '1', 02:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:58 INFO - 'PWD': '/builds/slave/test', 02:27:58 INFO - 'SHELL': '/bin/bash', 02:27:58 INFO - 'SHLVL': '1', 02:27:58 INFO - 'TERM': 'linux', 02:27:58 INFO - 'TMOUT': '86400', 02:27:58 INFO - 'USER': 'cltbld', 02:27:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:58 INFO - '_': '/tools/buildbot/bin/python'} 02:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:58 INFO - Downloading/unpacking psutil>=3.1.1 02:27:58 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 02:27:58 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 02:27:58 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 02:27:58 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 02:27:58 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 02:27:58 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 02:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:00 INFO - Installing collected packages: psutil 02:28:00 INFO - Running setup.py install for psutil 02:28:00 INFO - building 'psutil._psutil_linux' extension 02:28:00 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 02:28:01 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 02:28:01 INFO - building 'psutil._psutil_posix' extension 02:28:01 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 02:28:01 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 02:28:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:01 INFO - Successfully installed psutil 02:28:01 INFO - Cleaning up... 02:28:01 INFO - Return code: 0 02:28:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:28:01 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')]} 02:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:01 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')]} 02:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:01 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:28:01 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 02:28:01 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 02:28:01 INFO - Using env: {'DISPLAY': ':0', 02:28:01 INFO - 'HOME': '/home/cltbld', 02:28:01 INFO - 'LANG': 'en_US.UTF-8', 02:28:01 INFO - 'LANGUAGE': 'en_US:en', 02:28:01 INFO - 'LOGNAME': 'cltbld', 02:28:01 INFO - 'MAIL': '/var/mail/cltbld', 02:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:01 INFO - 'MOZ_NO_REMOTE': '1', 02:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:01 INFO - 'NO_EM_RESTART': '1', 02:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:01 INFO - 'PWD': '/builds/slave/test', 02:28:01 INFO - 'SHELL': '/bin/bash', 02:28:01 INFO - 'SHLVL': '1', 02:28:01 INFO - 'TERM': 'linux', 02:28:01 INFO - 'TMOUT': '86400', 02:28:01 INFO - 'USER': 'cltbld', 02:28:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:01 INFO - '_': '/tools/buildbot/bin/python'} 02:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:28:01 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 02:28:01 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 02:28:01 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 02:28:01 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 02:28:01 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 02:28:01 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 02:28:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:28:03 INFO - Installing collected packages: mozsystemmonitor 02:28:03 INFO - Running setup.py install for mozsystemmonitor 02:28:04 INFO - Successfully installed mozsystemmonitor 02:28:04 INFO - Cleaning up... 02:28:04 INFO - Return code: 0 02:28:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:28:04 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')]} 02:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:04 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')]} 02:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:04 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:28:04 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 02:28:04 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 02:28:04 INFO - Using env: {'DISPLAY': ':0', 02:28:04 INFO - 'HOME': '/home/cltbld', 02:28:04 INFO - 'LANG': 'en_US.UTF-8', 02:28:04 INFO - 'LANGUAGE': 'en_US:en', 02:28:04 INFO - 'LOGNAME': 'cltbld', 02:28:04 INFO - 'MAIL': '/var/mail/cltbld', 02:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:04 INFO - 'MOZ_NO_REMOTE': '1', 02:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:04 INFO - 'NO_EM_RESTART': '1', 02:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:04 INFO - 'PWD': '/builds/slave/test', 02:28:04 INFO - 'SHELL': '/bin/bash', 02:28:04 INFO - 'SHLVL': '1', 02:28:04 INFO - 'TERM': 'linux', 02:28:04 INFO - 'TMOUT': '86400', 02:28:04 INFO - 'USER': 'cltbld', 02:28:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:04 INFO - '_': '/tools/buildbot/bin/python'} 02:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:04 INFO - Downloading/unpacking jsonschema==2.5.1 02:28:04 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 02:28:04 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 02:28:04 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 02:28:04 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 02:28:04 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 02:28:04 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 02:28:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:28:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 INFO - Downloading functools32-3.2.3-2.tar.gz 02:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:28:06 INFO - warning: no files found matching '*.txt' 02:28:06 INFO - no previously-included directories found matching 'build' 02:28:06 INFO - no previously-included directories found matching 'dist' 02:28:06 INFO - no previously-included directories found matching '.git*' 02:28:06 INFO - Installing collected packages: jsonschema, functools32 02:28:06 INFO - Running setup.py install for functools32 02:28:06 INFO - warning: no files found matching '*.txt' 02:28:06 INFO - no previously-included directories found matching 'build' 02:28:06 INFO - no previously-included directories found matching 'dist' 02:28:06 INFO - no previously-included directories found matching '.git*' 02:28:06 INFO - Successfully installed jsonschema functools32 02:28:06 INFO - Cleaning up... 02:28:06 INFO - Return code: 0 02:28:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:28:06 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')]} 02:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:06 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')]} 02:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:06 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:28:06 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 02:28:06 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 02:28:06 INFO - Using env: {'DISPLAY': ':0', 02:28:06 INFO - 'HOME': '/home/cltbld', 02:28:06 INFO - 'LANG': 'en_US.UTF-8', 02:28:06 INFO - 'LANGUAGE': 'en_US:en', 02:28:06 INFO - 'LOGNAME': 'cltbld', 02:28:06 INFO - 'MAIL': '/var/mail/cltbld', 02:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:06 INFO - 'MOZ_NO_REMOTE': '1', 02:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:06 INFO - 'NO_EM_RESTART': '1', 02:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:06 INFO - 'PWD': '/builds/slave/test', 02:28:06 INFO - 'SHELL': '/bin/bash', 02:28:06 INFO - 'SHLVL': '1', 02:28:06 INFO - 'TERM': 'linux', 02:28:06 INFO - 'TMOUT': '86400', 02:28:06 INFO - 'USER': 'cltbld', 02:28:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:06 INFO - '_': '/tools/buildbot/bin/python'} 02:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:28:07 INFO - Cleaning up... 02:28:07 INFO - Return code: 0 02:28:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28:07 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')]} 02:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:07 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')]} 02:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:07 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:28:07 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 02:28:07 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 02:28:07 INFO - Using env: {'DISPLAY': ':0', 02:28:07 INFO - 'HOME': '/home/cltbld', 02:28:07 INFO - 'LANG': 'en_US.UTF-8', 02:28:07 INFO - 'LANGUAGE': 'en_US:en', 02:28:07 INFO - 'LOGNAME': 'cltbld', 02:28:07 INFO - 'MAIL': '/var/mail/cltbld', 02:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:07 INFO - 'MOZ_NO_REMOTE': '1', 02:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:07 INFO - 'NO_EM_RESTART': '1', 02:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:07 INFO - 'PWD': '/builds/slave/test', 02:28:07 INFO - 'SHELL': '/bin/bash', 02:28:07 INFO - 'SHLVL': '1', 02:28:07 INFO - 'TERM': 'linux', 02:28:07 INFO - 'TMOUT': '86400', 02:28:07 INFO - 'USER': 'cltbld', 02:28:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:07 INFO - '_': '/tools/buildbot/bin/python'} 02:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:07 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:07 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 02:28:07 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 02:28:07 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 02:28:07 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 02:28:07 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 02:28:07 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 02:28:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28:09 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 02:28:09 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 02:28:09 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 02:28:09 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 02:28:09 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 02:28:09 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 02:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:28:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:28:09 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 02:28:09 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 02:28:09 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 02:28:09 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 02:28:09 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 02:28:09 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 02:28:09 INFO - Downloading docopt-0.6.1.tar.gz 02:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:28:10 INFO - Installing collected packages: blobuploader, requests, docopt 02:28:10 INFO - Running setup.py install for blobuploader 02:28:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:28:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:28:10 INFO - Running setup.py install for requests 02:28:10 INFO - Running setup.py install for docopt 02:28:10 INFO - Successfully installed blobuploader requests docopt 02:28:10 INFO - Cleaning up... 02:28:10 INFO - Return code: 0 02:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:10 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')]} 02:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:10 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')]} 02:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:10 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:28:10 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 02:28:10 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 02:28:10 INFO - Using env: {'DISPLAY': ':0', 02:28:10 INFO - 'HOME': '/home/cltbld', 02:28:10 INFO - 'LANG': 'en_US.UTF-8', 02:28:10 INFO - 'LANGUAGE': 'en_US:en', 02:28:10 INFO - 'LOGNAME': 'cltbld', 02:28:10 INFO - 'MAIL': '/var/mail/cltbld', 02:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:10 INFO - 'MOZ_NO_REMOTE': '1', 02:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:10 INFO - 'NO_EM_RESTART': '1', 02:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:10 INFO - 'PWD': '/builds/slave/test', 02:28:10 INFO - 'SHELL': '/bin/bash', 02:28:10 INFO - 'SHLVL': '1', 02:28:10 INFO - 'TERM': 'linux', 02:28:10 INFO - 'TMOUT': '86400', 02:28:10 INFO - 'USER': 'cltbld', 02:28:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:10 INFO - '_': '/tools/buildbot/bin/python'} 02:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:10 INFO - Running setup.py (path:/tmp/pip-KSiMtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:10 INFO - Running setup.py (path:/tmp/pip-DT8ZdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:10 INFO - Running setup.py (path:/tmp/pip-IFzIeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:11 INFO - Running setup.py (path:/tmp/pip-WR6W7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:11 INFO - Running setup.py (path:/tmp/pip-0Lk8iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:11 INFO - Running setup.py (path:/tmp/pip-Uhfc3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:11 INFO - Running setup.py (path:/tmp/pip-9K5XA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:11 INFO - Running setup.py (path:/tmp/pip-kaT7Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:11 INFO - Running setup.py (path:/tmp/pip-NeLu2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:11 INFO - Running setup.py (path:/tmp/pip-E7yDWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:11 INFO - Running setup.py (path:/tmp/pip-xrqvev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:11 INFO - Running setup.py (path:/tmp/pip-XXMpVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:11 INFO - Running setup.py (path:/tmp/pip-NczZlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:11 INFO - Running setup.py (path:/tmp/pip-I603Vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:11 INFO - Running setup.py (path:/tmp/pip-_b5IiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:11 INFO - Running setup.py (path:/tmp/pip-qQRsGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:11 INFO - Running setup.py (path:/tmp/pip-ptX0PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:28:12 INFO - Running setup.py install for manifestparser 02:28:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:28:12 INFO - Running setup.py install for mozcrash 02:28:12 INFO - Running setup.py install for mozdebug 02:28:12 INFO - Running setup.py install for mozdevice 02:28:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:28:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:28:12 INFO - Running setup.py install for mozfile 02:28:12 INFO - Running setup.py install for mozhttpd 02:28:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:28:12 INFO - Running setup.py install for mozinfo 02:28:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:28:12 INFO - Running setup.py install for mozInstall 02:28:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:28:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:28:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:28:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:28:12 INFO - Running setup.py install for mozleak 02:28:12 INFO - Running setup.py install for mozlog 02:28:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:28:13 INFO - Running setup.py install for moznetwork 02:28:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:28:13 INFO - Running setup.py install for mozprocess 02:28:13 INFO - Running setup.py install for mozprofile 02:28:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:13 INFO - Running setup.py install for mozrunner 02:28:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:13 INFO - Running setup.py install for mozscreenshot 02:28:13 INFO - Running setup.py install for moztest 02:28:13 INFO - Running setup.py install for mozversion 02:28:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:13 INFO - Cleaning up... 02:28:13 INFO - Return code: 0 02:28:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:13 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:28:13 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 02:28:13 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 02:28:13 INFO - Using env: {'DISPLAY': ':0', 02:28:13 INFO - 'HOME': '/home/cltbld', 02:28:13 INFO - 'LANG': 'en_US.UTF-8', 02:28:13 INFO - 'LANGUAGE': 'en_US:en', 02:28:13 INFO - 'LOGNAME': 'cltbld', 02:28:13 INFO - 'MAIL': '/var/mail/cltbld', 02:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:13 INFO - 'MOZ_NO_REMOTE': '1', 02:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:13 INFO - 'NO_EM_RESTART': '1', 02:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:13 INFO - 'PWD': '/builds/slave/test', 02:28:13 INFO - 'SHELL': '/bin/bash', 02:28:13 INFO - 'SHLVL': '1', 02:28:13 INFO - 'TERM': 'linux', 02:28:13 INFO - 'TMOUT': '86400', 02:28:13 INFO - 'USER': 'cltbld', 02:28:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:13 INFO - '_': '/tools/buildbot/bin/python'} 02:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:14 INFO - Running setup.py (path:/tmp/pip-zmPXaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:14 INFO - Running setup.py (path:/tmp/pip-0bjun6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:14 INFO - Running setup.py (path:/tmp/pip-nYn_Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:14 INFO - Running setup.py (path:/tmp/pip-Bv5UB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:14 INFO - Running setup.py (path:/tmp/pip-9sKBEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:14 INFO - Running setup.py (path:/tmp/pip-uvwK_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:14 INFO - Running setup.py (path:/tmp/pip-KxmYwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:14 INFO - Running setup.py (path:/tmp/pip-qLfMF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:14 INFO - Running setup.py (path:/tmp/pip-PMZ8Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:14 INFO - Running setup.py (path:/tmp/pip-2Z5QIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:14 INFO - Running setup.py (path:/tmp/pip-l3Fqw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:14 INFO - Running setup.py (path:/tmp/pip-_ORfDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:14 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)) 02:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:14 INFO - Running setup.py (path:/tmp/pip-ERmxO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:15 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)) 02:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:15 INFO - Running setup.py (path:/tmp/pip-E1S5DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:15 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)) 02:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:15 INFO - Running setup.py (path:/tmp/pip-QwNZnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:15 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)) 02:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:15 INFO - Running setup.py (path:/tmp/pip-KS0IBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:15 INFO - Running setup.py (path:/tmp/pip-6Zdl5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28:15 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 02:28:15 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 02:28:15 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 02:28:15 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 02:28:15 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 02:28:15 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 02:28:17 INFO - Downloading blessings-1.6.tar.gz 02:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:17 INFO - Installing collected packages: blessings 02:28:17 INFO - Running setup.py install for blessings 02:28:17 INFO - Successfully installed blessings 02:28:17 INFO - Cleaning up... 02:28:17 INFO - Return code: 0 02:28:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:17 INFO - Reading from file tmpfile_stdout 02:28:17 INFO - Current package versions: 02:28:17 INFO - argparse == 1.2.1 02:28:17 INFO - blessings == 1.6 02:28:17 INFO - blobuploader == 1.2.4 02:28:17 INFO - docopt == 0.6.1 02:28:17 INFO - functools32 == 3.2.3-2 02:28:17 INFO - jsonschema == 2.5.1 02:28:17 INFO - manifestparser == 1.1 02:28:17 INFO - mozInstall == 1.12 02:28:17 INFO - mozcrash == 1.0 02:28:17 INFO - mozdebug == 0.1 02:28:17 INFO - mozdevice == 0.48 02:28:17 INFO - mozfile == 1.2 02:28:17 INFO - mozhttpd == 0.7 02:28:17 INFO - mozinfo == 0.9 02:28:17 INFO - mozleak == 0.1 02:28:17 INFO - mozlog == 3.4 02:28:17 INFO - moznetwork == 0.27 02:28:17 INFO - mozprocess == 0.23 02:28:17 INFO - mozprofile == 0.28 02:28:17 INFO - mozrunner == 6.13 02:28:17 INFO - mozscreenshot == 0.1 02:28:17 INFO - mozsystemmonitor == 0.3 02:28:17 INFO - moztest == 0.7 02:28:17 INFO - mozversion == 1.4 02:28:17 INFO - psutil == 3.1.1 02:28:17 INFO - requests == 1.2.3 02:28:17 INFO - wsgiref == 0.1.2 02:28:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:17 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:28:17 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 02:28:17 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 02:28:17 INFO - Using env: {'DISPLAY': ':0', 02:28:17 INFO - 'HOME': '/home/cltbld', 02:28:17 INFO - 'LANG': 'en_US.UTF-8', 02:28:17 INFO - 'LANGUAGE': 'en_US:en', 02:28:17 INFO - 'LOGNAME': 'cltbld', 02:28:17 INFO - 'MAIL': '/var/mail/cltbld', 02:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:17 INFO - 'MOZ_NO_REMOTE': '1', 02:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:17 INFO - 'NO_EM_RESTART': '1', 02:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:17 INFO - 'PWD': '/builds/slave/test', 02:28:17 INFO - 'SHELL': '/bin/bash', 02:28:17 INFO - 'SHLVL': '1', 02:28:17 INFO - 'TERM': 'linux', 02:28:17 INFO - 'TMOUT': '86400', 02:28:17 INFO - 'USER': 'cltbld', 02:28:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:17 INFO - '_': '/tools/buildbot/bin/python'} 02:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:18 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)) 02:28:18 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)) 02:28:18 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)) 02:28:18 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)) 02:28:18 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)) 02:28:18 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)) 02:28:18 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)) 02:28:18 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)) 02:28:18 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)) 02:28:18 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)) 02:28:18 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)) 02:28:18 INFO - Cleaning up... 02:28:18 INFO - Return code: 0 02:28:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:18 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')]} 02:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:18 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')]} 02:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:18 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 0x7f3d2bf9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ecca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', '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 02:28:18 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 02:28:18 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 02:28:18 INFO - Using env: {'DISPLAY': ':0', 02:28:18 INFO - 'HOME': '/home/cltbld', 02:28:18 INFO - 'LANG': 'en_US.UTF-8', 02:28:18 INFO - 'LANGUAGE': 'en_US:en', 02:28:18 INFO - 'LOGNAME': 'cltbld', 02:28:18 INFO - 'MAIL': '/var/mail/cltbld', 02:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:18 INFO - 'MOZ_NO_REMOTE': '1', 02:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:18 INFO - 'NO_EM_RESTART': '1', 02:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:18 INFO - 'PWD': '/builds/slave/test', 02:28:18 INFO - 'SHELL': '/bin/bash', 02:28:18 INFO - 'SHLVL': '1', 02:28:18 INFO - 'TERM': 'linux', 02:28:18 INFO - 'TMOUT': '86400', 02:28:18 INFO - 'USER': 'cltbld', 02:28:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:18 INFO - '_': '/tools/buildbot/bin/python'} 02:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:18 INFO - Cleaning up... 02:28:18 INFO - Return code: 0 02:28:18 INFO - Running post-action listener: _resource_record_post_action 02:28:18 INFO - Running post-action listener: _start_resource_monitoring 02:28:18 INFO - Starting resource monitoring. 02:28:18 INFO - [mozharness: 2016-12-30 10:28:18.288415Z] Finished create-virtualenv step (success) 02:28:18 INFO - [mozharness: 2016-12-30 10:28:18.288917Z] Running install step. 02:28:18 INFO - Running pre-action listener: _resource_record_pre_action 02:28:18 INFO - Running main action method: install 02:28:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:18 INFO - Reading from file tmpfile_stdout 02:28:18 INFO - Detecting whether we're running mozinstall >=1.0... 02:28:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:28:18 INFO - Reading from file tmpfile_stdout 02:28:18 INFO - Output received: 02:28:18 INFO - Usage: mozinstall [options] installer 02:28:18 INFO - Options: 02:28:18 INFO - -h, --help show this help message and exit 02:28:18 INFO - -d DEST, --destination=DEST 02:28:18 INFO - Directory to install application into. [default: 02:28:18 INFO - "/builds/slave/test"] 02:28:18 INFO - --app=APP Application being installed. [default: firefox] 02:28:18 INFO - mkdir: /builds/slave/test/build/application 02:28:18 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'] 02:28:18 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 02:28:34 INFO - Reading from file tmpfile_stdout 02:28:34 INFO - Output received: 02:28:34 INFO - /builds/slave/test/build/application/firefox/firefox 02:28:34 INFO - Running post-action listener: _resource_record_post_action 02:28:34 INFO - [mozharness: 2016-12-30 10:28:34.493049Z] Finished install step (success) 02:28:34 INFO - [mozharness: 2016-12-30 10:28:34.493333Z] Running run-tests step. 02:28:34 INFO - Running pre-action listener: _resource_record_pre_action 02:28:34 INFO - Running main action method: run_tests 02:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:28:34 INFO - Python 2.7.3 02:28:34 INFO - Return code: 0 02:28:34 INFO - grabbing minidump binary from tooltool 02:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:34 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 0x22e9f60>, '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 0x22ead40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:28:34 INFO - Return code: 0 02:28:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:28:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:28:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:28:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:28:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:28:34 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/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 02:28:34 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/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 02:28:34 INFO - Using env: {'DISPLAY': ':0', 02:28:34 INFO - 'HOME': '/home/cltbld', 02:28:34 INFO - 'LANG': 'en_US.UTF-8', 02:28:34 INFO - 'LANGUAGE': 'en_US:en', 02:28:34 INFO - 'LOGNAME': 'cltbld', 02:28:34 INFO - 'MAIL': '/var/mail/cltbld', 02:28:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:28:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:34 INFO - 'MOZ_NO_REMOTE': '1', 02:28:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:34 INFO - 'NO_EM_RESTART': '1', 02:28:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:34 INFO - 'PWD': '/builds/slave/test', 02:28:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:28:34 INFO - 'SHELL': '/bin/bash', 02:28:34 INFO - 'SHLVL': '1', 02:28:34 INFO - 'TERM': 'linux', 02:28:34 INFO - 'TMOUT': '86400', 02:28:34 INFO - 'USER': 'cltbld', 02:28:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309', 02:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:34 INFO - '_': '/tools/buildbot/bin/python'} 02:28:34 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/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 02:28:34 INFO - mozversion application_buildid: 20161230004019 02:28:34 INFO - mozversion application_changeset: b213de949cddebe0a123654be580ba114b951020 02:28:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:28:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:28:34 INFO - mozversion application_name: Firefox 02:28:34 INFO - mozversion application_remotingname: firefox-dev 02:28:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:34 INFO - mozversion application_vendor: Mozilla 02:28:34 INFO - mozversion application_version: 52.0a2 02:28:34 INFO - mozversion platform_buildid: 20161230004019 02:28:34 INFO - mozversion platform_changeset: b213de949cddebe0a123654be580ba114b951020 02:28:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:34 INFO - mozversion platform_version: 52.0a2 02:28:34 INFO - using testdate: 1483093714 02:28:34 INFO - actual date: 1483093714 02:28:34 INFO - starting webserver on 'localhost:45667' 02:28:34 INFO - SUITE-START | Running 2 tests 02:28:34 INFO - TEST-START | dromaeo_css 02:28:34 INFO - operating with platform_type : linux_ 02:28:34 INFO - Initialising browser for dromaeo_css test... 02:28:34 INFO - TEST-INFO | started process 25265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7A4TdR/profile http://localhost:45667/getInfo.html) 02:28:38 INFO - PROCESS | 25265 | __metrics Screen width/height:1600/1200 02:28:38 INFO - PROCESS | 25265 | colorDepth:24 02:28:38 INFO - PROCESS | 25265 | Browser inner width/height: 1024/697 02:28:38 INFO - PROCESS | 25265 | __metrics 02:28:39 INFO - PROCESS | 25265 | 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" 02:28:39 INFO - PROCESS | 25265 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:28:39 INFO - PROCESS | 25265 | console.error: PushService: 02:28:39 INFO - PROCESS | 25265 | stateChangeProcessEnqueue: Error transitioning state 02:28:39 INFO - PROCESS | 25265 | UnknownError 02:28:40 INFO - TEST-INFO | 25265: exit 0 02:28:40 INFO - Browser initialized. 02:28:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:28:40 INFO - TEST-INFO | started process 25357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7A4TdR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:51 INFO - PROCESS | 25357 | RSS: Main: 144912384 02:28:51 INFO - PROCESS | 25357 | 02:29:43 INFO - PROCESS | 25357 | 1483093783494 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:31:53 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:45667/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45667/tests/dromaeo/cssquery-ext.html) 02:31:54 INFO - PROCESS | 25357 | RSS: Main: 238927872 02:31:54 INFO - PROCESS | 25357 | 02:34:57 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:45667/tests/dromaeo/cssquery-ext.html (next: http://localhost:45667/tests/dromaeo/cssquery-jquery.html) 02:34:57 INFO - PROCESS | 25357 | RSS: Main: 227815424 02:34:57 INFO - PROCESS | 25357 | 02:37:59 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:45667/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45667/tests/dromaeo/cssquery-mootools.html) 02:38:00 INFO - PROCESS | 25357 | RSS: Main: 175972352 02:38:00 INFO - PROCESS | 25357 | 02:41:02 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:45667/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45667/tests/dromaeo/cssquery-prototype.html) 02:41:03 INFO - PROCESS | 25357 | RSS: Main: 216678400 02:41:03 INFO - PROCESS | 25357 | 02:44:05 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:45667/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45667/tests/dromaeo/cssquery-yui.html) 02:44:06 INFO - PROCESS | 25357 | RSS: Main: 176132096 02:44:06 INFO - PROCESS | 25357 | 02:47:08 INFO - PROCESS | 25357 | Cycle 1(1): loaded http://localhost:45667/tests/dromaeo/cssquery-yui.html (next: http://localhost:45667/tests/dromaeo/cssquery-dojo.html) 02:47:08 INFO - PROCESS | 25357 | RSS: Main: 267751424 02:47:08 INFO - PROCESS | 25357 | 02:47:08 INFO - PROCESS | 25357 | __start_tp_report 02:47:08 INFO - PROCESS | 25357 | _x_x_mozilla_page_load 02:47:08 INFO - PROCESS | 25357 | _x_x_mozilla_page_load_details 02:47:08 INFO - PROCESS | 25357 | |i|pagename|runs| 02:47:08 INFO - PROCESS | 25357 | |0;dojo.html;3236.563063986362;3260.527223552586;3274.2632907595794;3294.407006738786;3312.90061298161;5470.370907345657;5527.889442211163;5539.196816461611;5540.252065971093;5553.916691249635;5529.087700529408;5565.860853478665;5599.188117722928;5623.80316688916;5632.26780518532;5042.924356134661;5061.392632884059;5082.872928176788;5135.306733590974;5166.405863325709;4950.282209079682;4971.05549945511;5103.106956282654;5150.9742451287875;5157.6131790115705;5000.324956130912;5021.84934451967;5049.040682270375;5060.418051924021;5062.341895553573;5092.618053645972;5120.974395128001;5123.129068058439;5189.766460509286;5192.221166824968;5002.824901128443;5075.619328550373;5140.228965655144;5157.613179011551;5186.325777648919;5384.892302153974;5441.891162176774;5444.50999410051;5453.918191227135;5489.725513724298;5895.4694077532795;5905.852353691193;5909.940900590982;5998.1602575639445;6000.33996260411;6011.909821352683;6021.849453763691;6030.577859549833;6046;6048.971674815292;5438.374586922515;5468.72656367184;5526.917096243559;5567.137093750475;5579.163125531203;6050.727717252734;6058.4244496772735;6075.726592303268;6087.878242435127;6093.451589356979;5838.678872662044;5844.473997340175;5852.326982396994;5867.823965281048;5871.647701137946;5726.284214473191;5791.681457519877;5798.536117110621;5872.530197584183;5883.14694369314;5913.29040515141;5931.584789064724;5932.970335148383;5953.880922381528;5954.196183515257;5884.146798714162;5923.348431672513;5933.6736479493175;5938.851528711817;5953.226080609493;4391.297392417198;4448.955510444855;4582.9770851146195;4631.58315751584;4637.976810115995;4129.070959034193;4163.188178305262;4167.97916010418;4174.749515029108;4199.769012704331;5793.304803423532;5813.244278243801;5814;5828.388019258002;5832.445917637902;5794.420557944256;5841.94158058414;5916.408359164136;6031.638101713911;6043.123747056652;5763.049096899049;5830.591858569945;5839.328477225174;5852.385499522574;5868.501177399969;5230.424653288135;5232.581393488512;5233.267342571967;5235.607329450307;5239.161734122598;6037;6130.264368275657;6282.528810339334;6347.587406818542;6360.586561873556;5892.469677729025;5897.67562784051;5966.70166491665;6045.6070355426755;6057.606255593372;6275.905861411991;6326.272478664829;6327.367263273636;6328.367163283635;6335.493160547053;5895.351511333835;5895.380984996686;5896.911546326723;5900.822975310747;5929.407059294036;5737;5840.357560668408;5895.587308888336;5948.910766338595;5951.58338916289;5809.36097029318;5849.736761845812;5852.619579727304;5876.500497457764;5894.086416605433;5854.2389489366105;5860.472557469848;5863.618864773776;5867.471927526543;5876.059830427112;5648.378678345297;5701.258836351248;5706.914396283976;5757.510611598061;5769.624974376652;5854.677992710442;5857.062869940789;5864.179014937998;5879.941200587939;5896.6756828374855;5608.551315894801;5653.293338332708;5705.885882282248;5714.314282285986;5722 02:47:08 INFO - PROCESS | 25357 | |1;ext.html;576.2882839692978;614.066618739516;624.9532033843312;642.5116911147529;666.0142988377198;33329.33341333175;44347.556524434745;45560.3165952511;45572.54427455724;45596.772016139876;45927.54072459274;46231.30653040207;46306;46372;46431;8257.339412846957;8814.86777698335;8964.193222609963;8967.596458159365;8971.14774096463;8277.503349799;10478.790424191511;10719.410432426213;10743.677689669323;11069.778604427907;10505.68482945513;10534.631287904887;10559.947200263989;10577.259591828575;10581.84127238092;10745.677629671123;10768.084712799422;10808.729781755519;10812.405317707522;10816.296940698829;10680.25238233324;10742.838857417146;10760.78478430435;10761.408122553257;10767.353958762422;43825.56174438247;44072.55927440717;44131.55868441339;44138;44190.33714494285;3667.963320366789;3700.85196592136;3747.512823332949;3864.632859878307;4401.207782599131;32538;32818.12238297947;33018.6698133018;33281.83359083189;33853.661463385295;4075.551689314173;4105.199486100211;4150.875473735793;4173.833046678129;4242.278812601834;367552;368693.1565342183;368752;368815;369223;60867.695661522295;61131.69434152801;61246;61253.38746612566;61298.69350653218;38557.228855422734;40086.59913400887;40276.79861600673;43268;43287.35068973968;16819.32722691103;16894.831051689573;16952.74570881438;16986.83013169877;17010.404635837687;12487.250764954131;12815.487380504861;13337.73324533504;13814.309284535733;13937.512187073404;20487.69268460974;20662.17351305961;20695.379138625864;20707.792922070887;20839.374818755463;7158.2125966143685;7317.5609463432365;7374.3363097320425;7416.22129676387;7493.66278517468;1029.6705054382676;1067.9305845120043;1125.319181894958;1127.9943600281947;1152.0783373301326;33332.666673332955;33769.49345759815;34018.829905850806;34074.44862509512;34126.146846329044;999.4053538144792;1113.87190473095;1134.7390100276982;1142.9028532574823;1214.3078445286278;16231.918840405722;17978;18075.186616602285;18642.34751783681;18765.43703688864;564144;566043;566795;567858;569956;59852.70073649604;60478.395216047276;60502;60798;60920.39079609236;1264.563725514696;1292.0309767674244;1370.54086880896;1388.125480946997;1388.8402833674054;29600.259993500335;33095.834520828204;34070.82964585161;34218.292011566155;34397.656023440446;50905.236421452966;51172.232416514526;51453.48546514637;51492;51515.48484515257;384982;388931;389012;389673;390056;29274;30800.69199307978;31120.844395778782;32439.02682919516;32459;47851.76074119607;48598.75700621474;48828.26757598568;48919.75540122276;49990.75004625099;41293.58706412897;41502.792486037375;41848.790756047245;43433.78283108564;43754.124917500834;41311.586884130775;41445.79277103595;42595.10733899151;43118.35322470228;43162;42752;43187;43711.56288437075;43846.56153438425;43878.34182487201;36009.639903601674;37709.4343584841;38383.23233535369;38585.22829543337;38819.41770873496;28585.714142858305;28725.42549149047;28924.132276031753;29010.709892900803;29146.854265728536 02:47:08 INFO - PROCESS | 25357 | |2;jquery.html;392.2152715718398;435.86270324847675;439.63290652305324;440.82367053178734;444.8954495693512;17324.307027718893;19819.108140133692;20634.48413789656;20691.172353105856;20963.790362096395;20070.29753958608;20284.29004984826;20321.288754893583;20366.59266814663;20548.794512054876;5717.2281741964825;5932.3474417814;5933.495652869489;5937.703114844262;5938.46553810157;5779.508741756956;6041.667708276043;6077.4530292273685;6139.6009259398215;6150;6007.044253254362;6101.847453813668;6153.046277826944;6168;6171.814845554618;6079.20970273866;6174.567780255384;6182.227221597301;6183.072539119145;6185.072239164117;5794;5986;6008.3390827009;6033.607815491979;6041.879162416727;14711.926440367837;14961;14965.925170374187;22349.441263968532;23679.526409471713;2360.362702070431;2384.582698027838;2458.7172475165225;2500.549901017816;2971.7028297170327;10820.458977051194;10857.077148442391;11168.106551475863;11379.943100284445;11420.942895285554;1854.7496088028079;1861.3206179744432;1861.821221378603;1885.6794344961252;1939.5151212196952;84319.15680843174;86880.13119868847;88338.55830720869;88636.11363886343;89958.6506202414;10323.94838025805;11856.110791690659;11862.940685296518;11969.247073173045;12054.638360849189;15442.0734755915;15606.765898511305;16399.590010249838;16511.752323715154;17127.914360428367;7796.688132474637;7856.057273127261;7900.130985591581;7946.284834364935;8045.919540804517;7083.7520686775715;7088.432925365958;7092.574445533284;7265.782026539212;7274.127104747358;5100.413452452941;5139.357580302462;5151.047056294523;5192.844214673566;5270;2049.610573990937;2088.9764015632536;2129.520857807012;2131.4085765485206;2151.5911976724374;923.4320892650971;964.4695417520336;1012.7063151686076;1056.894310568937;1082.5074591061048;19894.204231830856;20049.198032078846;20530.69203961942;20531;20561.280355187497;984.4241118945497;993.7118235711563;1006.1950439648252;1041.9895801042044;1086.6631344283298;10347.84478232812;11406.714832129097;11433.59982400612;11518.769624607461;11686.065114790796;458672;478204;485156;487006;487117;89651;92251;97306;97383;97424.51287743516;885.6457417033109;897.3225214962662;926.9860952085725;928.224932181636;1017.0439786600572;17800.287988480835;18319.908400457913;18486.630267394845;18617;18655;36611;38541.80729096449;43651.781741091094;44711.55288447204;44863.775681121384;58543.4145658538;62681;63520;64179.35820641734;65525;8816.338774591803;12198.268103913793;12650.746985060063;12719.87280127187;13033.47866085346;13229.40467678976;13558.728825423634;14227.715445691236;14374.137551746928;14406.855931440552;12681.492740290285;12835.93582032084;12875;13113.409896554487;13213.405396757362;12670.493180272686;12705.936470317589;12865.035122365673;13107.672308192372;13296.534621288209;13027.47890084386;13206.27365494907;13352.132111412728;13393;13457.125286856322;12912.289824059766;13030.609081727564;13231.139975901535;13268.53560125391;13336.866631333562;13006.804897926728;13014.15407998477;13111;13176.868231317947;13493.460261589427 02:47:08 INFO - PROCESS | 25357 | |3;mootools.html;1296.6563860576955;1421.6872288096615;1467.9412823487062;1594.2985086561912;1774.6894293498635;7514.924850751498;8171.264586187242;8443.155684431555;8449.957750211248;8664.783380415493;8482.194191551793;8543.65825366986;8550.828983420328;8554.572271386436;8557.91442085579;2291.3584196424986;2319.3042087373806;2321.106374045996;2322.222055611372;2324.9186278480256;2290.7365652949875;2319.5013072189477;2366.668666386707;2370.7155141382973;2374.2165085521824;2299.827512936528;2300.804431623314;2317.1079134533156;2318.8840557972117;2325.2094287942095;2210.7347118345742;2219.6448568229166;2226.510167763098;2226.7661895501064;2247.1460844878843;2059.680749483832;2063.8452116091353;2072.1504183284783;2073.3054426767053;2255.57144142614;8648.524331161783;8693.956530217309;8707.912920870773;8724.563771811385;8745.344099192585;5262.657927234755;5463.235147079412;5471.890562188773;5553.916691249635;5574.693391863446;3362.3107263011025;3427.6915077642884;3474.2009337852437;3531.682148606638;3546.148924258185;1094.4254266510065;1109.4397329348628;1117.2235296468957;1147.1224513247373;1148.26511032939;11839.881601183964;11947.163698541019;12008;12057;12067.094967877356;4359.80380882861;4620.653450991122;4687.789049492781;4700.529947005341;4717.174494463455;9674.322797404255;9713.757156071155;9722.125008749246;9740.464274464972;9746.853797193047;5420.7289635518855;5424.159255315432;5425.186222066722;5433.212184233343;5434.456554344534;4277.893052673708;4423.402840616475;4627.3521706961055;5052.191649336162;5067.8986420271385;3748.4002559590335;3795.9240815184094;3874.6706529945272;3884.533855937249;3888.6111388860886;1163.4124766992616;1192.4872304908972;1194.8506436695413;1197.2457351868268;1210.9091818113677;854.9633445611304;912.169925367912;949.4967667136428;962.9711108666751;1015.0914931136591;5605.607607467438;5791.82624521265;5850.151727999416;5882.02946513829;6083.148359229712;449.3933190193278;450.5179457979996;450.99774501127285;456.3086923311186;463.3813858498942;3969.2458432898234;4034.838606455709;4051.372037334218;4083.448734420815;4122.824994876446;10151.94924025375;10866.891331086747;10885.510152043018;10894;10958.945205273923;10131.341462804894;10370.170386369073;10695.465226738632;10788.676339709822;10842.891571084188;7864.859595358641;8040.150765324008;8071.919280807234;8079.353651707849;8095.878561821577;5958.791442299499;6024.7288872001745;6047.153398524122;6052;6111.816645500642;9287.489188094449;9811.509424528887;9849.753756155867;9857.211423086279;9933.205343572352;8629.180227878342;8835.160659737314;9704.126628603459;10052.296339256181;10079.34484258521;7489.737859174903;7670;7744.65149068282;7845.764627061198;7853.2932036114735;8540.701075462577;8579.742607721779;8635.956820215859;8641.524716140673;8643.56782160902;7474.663640136316;7581.469297149147;7598.392128629807;7700.691972321044;7856.646450909609;7322.267773222635;7428.1086269647985;7464.1789403166695;7502.437317201341;7733.226677332222;6961.6519174042105;7099.325564071405;7103.041089452858;7103.964480177566;7106.857862842818;5307.363116426053;5315.654482458628;5317.627766056339;5325.653832500875;5507.862303442285;5304.7347632618985;5335;5354.143337066051;5367.651102678314;5496.763228273607 02:47:08 INFO - PROCESS | 25357 | |4;prototype.html;352.8641473032882;368.1495744829444;373.33173619221594;376.0485970494648;377.61483287047196;5131.563817075553;5269.341332333458;5287.39194992576;5290.497402746738;5304.257403963448;5075.543201111899;5208.817691380802;5246.973765131179;5251.894962100765;5253.553447956919;4207.263728847454;4217.45173127493;4221.24017676818;4241.1941731071;4242.406063151161;4076.694247931417;4194.685398595102;4205.327147656376;4223.788810559475;4236.618704316611;4197.139586384784;4203.285441474956;4207.831686732527;4210.368444733299;4217.882261200769;4185.497740271172;4196.349565817272;4197.202531519017;4204.2432362174795;4218.261804184255;3672.9081772955624;3771.3588689922503;3791.696664266852;3801.6768574671187;3805.56236032857;5119.926429795939;5121.385433747937;5138.897222055575;5139.17773156297;5149.150390185615;4815.194302136699;4816.253480710496;4822.63830212732;4825.589824864891;4833.492483289239;5303.257543943812;5441.945580544183;5457.727113644341;5485.985092757853;5509.614326997112;4136.296829538986;4159.417681524589;4160.167966406731;4161.8554897403155;4179.582041795827;5601.719914004324;5616.775328986836;5659.434056594308;5668.829935101953;5678.971605141948;4156.625903668684;4238.279492486285;4239.936400953989;4248.553901840262;4300.677449191323;4300.9247688077985;4307.698461107755;4324.2648749712625;4350.825966961286;4361.563843615613;4805.231163013971;4814.555633309993;4831.154547954094;4862.17343051682;4864.951350486521;5367.382750983609;5537.280153580089;5583.357913839879;5603.411641777636;5638.069718496402;1366.5763613279914;1393.3869097597026;1420.4673247532176;1435.5478024422273;1440.1143296872558;1008.9243306751877;1026.6714651311509;1032.1587905856702;1032.963846265377;1045.926785125034;5148.995945790535;5190;5199.66202196856;5204.21936709489;5212.244224587489;5390.679283575549;5402.51377376038;5410.540104091117;5420.376656684453;5446.21029950655;5084.796608135707;5175.171972484384;5180.456052114474;5191.97404012985;5411.729413529308;2871.6410448693914;2888.942221155565;2891.6096326995585;2899.594056832045;2912.8689208985647;5718.285214348207;5732.512736417451;5745.626534275259;5771.567132465082;5790.917403230712;5389.83830485086;5497.587680923867;5514.5864060194845;5533.253010843485;5536.612437129363;5685.829425117253;5689.857753556194;5705.343885453143;5709.687576531512;5717.885642287214;5326.866828329323;5364.490373414519;5459.781608735606;5498.51540084167;5506.752196151103;5575.351707938858;5613.214150018919;5617.736009397853;5627.803026894039;5649.830505084854;5918.378570250062;5929.822105336847;5950.523958083257;6001.749343996002;6012.070102515895;3980.0049987503126;4137.13120244752;4152.730072545275;4175.519815221289;4200.873973780792;5432.972835135799;5549;5657.971710141423;5677.51741102011;5686.687232202103;5400.351957765093;5538;5549.72251387421;5561.6663000220115;5590.888182236251;5482.890342193214;5493.807716729895;5516.641418307797;5518.668879867221;5524.447555244444;5331.973340133274;5459.441366458893;5505.697186654773;5505.724713764215;5545.500904918576;5475.534579560782;5506.284183056177;5536.7231638418725;5553.916691249715;5557.5553955682635;5307.097793375213;5435;5448.809291674931;5451.918221226605;5498.945010550004 02:47:08 INFO - PROCESS | 25357 | |5;yui.html;730.83556199855;735.9595222262774;741.0847603210035;827.1397746343803;895.1183084661607;15169.848301516995;15480.845191548095;15708.52874413768;15712.528624141294;15747.291371888265;14653.92673036636;14789.408423663068;15092.773608395883;15885.285162167702;15989.84010159898;832.334132693844;851.5018714052287;851.8381507513584;851.8764779107025;852.910444403338;843.2242337049898;847.2205570874779;847.7456762971115;849.7748096754334;850.8255807559435;885.5262434597491;886.1979908183105;886.5124181700071;887.1084560017174;887.3477993674644;880.295763389286;881.1452890696047;882.7969566999626;883.1080608585343;883.2713011765287;645.8191706322191;645.961242325462;646.0277282689569;646.205167643796;646.4279112985042;15798.605034874105;15848.286827092808;15896.205189740582;15901.522954311273;15969.441069562627;13777.517786877512;14096.365663545164;14561.78157327641;14670.413183472649;14838.851611483962;11989.160758746892;12322.199057061262;12470.314132722697;12549.372531373394;12806.615801525875;3894.1627550076587;3918.8236529355963;3934.803259836997;3966.960330396717;4008.7594744315434;41295.587044129476;47983.28025079626;60904.08643870345;65889;69056.30943690549;11774.882251177378;11959.103067269989;12038.879611203776;12113.576024839089;12271.509139634314;20867.686984695243;20942.685859712117;20963.161473541193;21064.473388165417;21091.261805836722;8675.609597568124;8736.475811451333;8789.077146899612;8794.120587941155;8812.559372031374;4617.8845528861375;4623;4702.177119004161;4837.177679794443;4853.514648535189;3618.945715814265;3677.0807298175455;3746.83139258734;3751.174741556853;3756.9436458453147;642.142739442849;648.9935100649028;649.6232185332495;650.388634683396;657.6810247030187;709.0357114324618;750.3771869348428;790.3203245209115;790.8220650353625;797.696875187425;9772.413655180711;9860.950695246478;9907.789189594394;10012.649557265606;10042.447665378328;681.57401623985;734.2840730288033;746.4140649590046;791.3985371117992;805.0822062848357;4503.954960450419;4585;4691.786126503356;4950.877853892635;4991.550760431579;73132.63433682904;74097;75985.24014759892;82764.58617706873;86137;70868.2913170872;72438.63780681063;72892;73282.26717732755;73334;67929.30176745522;69427.65286173536;70322;72858.63570682112;73464.63267683734;9821.852672210065;10384.065434110966;10437.32157409766;10457.633982810565;10548.156147508027;34213;39901.40147897842;44020;46507;46541.06917861691;57000;62938;65754.67122664356;66520;67939;11777.823332649845;12541.372931353579;12650.177738446971;12720.236785792882;12773.87226127764;13093.214407135602;13106.737865242832;13256.867431325563;13445.394957226752;14152;12516.311602861566;12627.305498197687;13076.476940922257;13642.93178534101;13749.106308089942;12645.430955607204;12663.746725065632;13241.11262819025;13577.32113394346;13625.114367566473;13148.276844773247;13385.732285354043;13527.188368697909;13839.930800345934;13919.164850109026;10980.450977451255;11009.724756881142;11170.27393219438;11379.158844909414;11863.525458981545;10229.980162092603;11164.274322169033;11339.149563782914;11645.708857278636;11817.231879927776 02:47:08 INFO - PROCESS | 25357 | __end_tp_report 02:47:08 INFO - PROCESS | 25357 | __start_cc_report 02:47:08 INFO - PROCESS | 25357 | _x_x_mozilla_cycle_collect,1000 02:47:08 INFO - PROCESS | 25357 | __end_cc_report 02:47:08 INFO - PROCESS | 25357 | __startTimestamp1483094828981__endTimestamp 02:47:08 INFO - PROCESS | 25357 | 02:47:08 INFO - PROCESS | 25357 | ------- Summary: start ------- 02:47:08 INFO - PROCESS | 25357 | Number of tests: 6 02:47:08 INFO - PROCESS | 25357 | 02:47:08 INFO - PROCESS | 25357 | [#0] dojo.html Cycles:165 Average:5551.29 Median:5809.36 stddev:619.14 (10.7%) stddev-sans-first:593.82 02:47:08 INFO - PROCESS | 25357 | Values: 3236.6 3260.5 3274.3 3294.4 3312.9 5470.4 5527.9 5539.2 5540.3 5553.9 5529.1 5565.9 5599.2 5623.8 5632.3 5042.9 5061.4 5082.9 5135.3 5166.4 4950.3 4971.1 5103.1 5151.0 5157.6 5000.3 5021.8 5049.0 5060.4 5062.3 5092.6 5121.0 5123.1 5189.8 5192.2 5002.8 5075.6 5140.2 5157.6 5186.3 5384.9 5441.9 5444.5 5453.9 5489.7 5895.5 5905.9 5909.9 5998.2 6000.3 6011.9 6021.8 6030.6 6046.0 6049.0 5438.4 5468.7 5526.9 5567.1 5579.2 6050.7 6058.4 6075.7 6087.9 6093.5 5838.7 5844.5 5852.3 5867.8 5871.6 5726.3 5791.7 5798.5 5872.5 5883.1 5913.3 5931.6 5933.0 5953.9 5954.2 5884.1 5923.3 5933.7 5938.9 5953.2 4391.3 4449.0 4583.0 4631.6 4638.0 4129.1 4163.2 4168.0 4174.7 4199.8 5793.3 5813.2 5814.0 5828.4 5832.4 5794.4 5841.9 5916.4 6031.6 6043.1 5763.0 5830.6 5839.3 5852.4 5868.5 5230.4 5232.6 5233.3 5235.6 5239.2 6037.0 6130.3 6282.5 6347.6 6360.6 5892.5 5897.7 5966.7 6045.6 6057.6 6275.9 6326.3 6327.4 6328.4 6335.5 5895.4 5895.4 5896.9 5900.8 5929.4 5737.0 5840.4 5895.6 5948.9 5951.6 5809.4 5849.7 5852.6 5876.5 5894.1 5854.2 5860.5 5863.6 5867.5 5876.1 5648.4 5701.3 5706.9 5757.5 5769.6 5854.7 5857.1 5864.2 5879.9 5896.7 5608.6 5653.3 5705.9 5714.3 5722.0 02:47:08 INFO - PROCESS | 25357 | 02:47:08 INFO - PROCESS | 25357 | [#1] ext.html Cycles:180 Average:60720.97 Median:211769.61 stddev:119297.05 (56.3%) stddev-sans-first:119546.24 02:47:08 INFO - PROCESS | 25357 | Values: 576.3 614.1 625.0 642.5 666.0 33329.3 44347.6 45560.3 45572.5 45596.8 45927.5 46231.3 46306.0 46372.0 46431.0 8257.3 8814.9 8964.2 8967.6 8971.1 8277.5 10478.8 10719.4 10743.7 11069.8 10505.7 10534.6 10559.9 10577.3 10581.8 10745.7 10768.1 10808.7 10812.4 10816.3 10680.3 10742.8 10760.8 10761.4 10767.4 43825.6 44072.6 44131.6 44138.0 44190.3 3668.0 3700.9 3747.5 3864.6 4401.2 32538.0 32818.1 33018.7 33281.8 33853.7 4075.6 4105.2 4150.9 4173.8 4242.3 367552.0 368693.2 368752.0 368815.0 369223.0 60867.7 61131.7 61246.0 61253.4 61298.7 38557.2 40086.6 40276.8 43268.0 43287.4 16819.3 16894.8 16952.7 16986.8 17010.4 12487.3 12815.5 13337.7 13814.3 13937.5 20487.7 20662.2 20695.4 20707.8 20839.4 7158.2 7317.6 7374.3 7416.2 7493.7 1029.7 1067.9 1125.3 1128.0 1152.1 33332.7 33769.5 34018.8 34074.4 34126.1 999.4 1113.9 1134.7 1142.9 1214.3 16231.9 17978.0 18075.2 18642.3 18765.4 564144.0 566043.0 566795.0 567858.0 569956.0 59852.7 60478.4 60502.0 60798.0 60920.4 1264.6 1292.0 1370.5 1388.1 1388.8 29600.3 33095.8 34070.8 34218.3 34397.7 50905.2 51172.2 51453.5 51492.0 51515.5 384982.0 388931.0 389012.0 389673.0 390056.0 29274.0 30800.7 31120.8 32439.0 32459.0 47851.8 48598.8 48828.3 48919.8 49990.8 41293.6 41502.8 41848.8 43433.8 43754.1 41311.6 41445.8 42595.1 43118.4 43162.0 42752.0 43187.0 43711.6 43846.6 43878.3 36009.6 37709.4 38383.2 38585.2 38819.4 28585.7 28725.4 28924.1 29010.7 29146.9 02:47:08 INFO - PROCESS | 25357 | 02:47:08 INFO - PROCESS | 25357 | [#2] jquery.html Cycles:180 Average:29587.63 Median:11546.66 stddev:79232.58 (686.2%) stddev-sans-first:79424.53 02:47:08 INFO - PROCESS | 25357 | Values: 392.2 435.9 439.6 440.8 444.9 17324.3 19819.1 20634.5 20691.2 20963.8 20070.3 20284.3 20321.3 20366.6 20548.8 5717.2 5932.3 5933.5 5937.7 5938.5 5779.5 6041.7 6077.5 6139.6 6150.0 6007.0 6101.8 6153.0 6168.0 6171.8 6079.2 6174.6 6182.2 6183.1 6185.1 5794.0 5986.0 6008.3 6033.6 6041.9 14711.9 14961.0 14965.9 22349.4 23679.5 2360.4 2384.6 2458.7 2500.5 2971.7 10820.5 10857.1 11168.1 11379.9 11420.9 1854.7 1861.3 1861.8 1885.7 1939.5 84319.2 86880.1 88338.6 88636.1 89958.7 10323.9 11856.1 11862.9 11969.2 12054.6 15442.1 15606.8 16399.6 16511.8 17127.9 7796.7 7856.1 7900.1 7946.3 8045.9 7083.8 7088.4 7092.6 7265.8 7274.1 5100.4 5139.4 5151.0 5192.8 5270.0 2049.6 2089.0 2129.5 2131.4 2151.6 923.4 964.5 1012.7 1056.9 1082.5 19894.2 20049.2 20530.7 20531.0 20561.3 984.4 993.7 1006.2 1042.0 1086.7 10347.8 11406.7 11433.6 11518.8 11686.1 458672.0 478204.0 485156.0 487006.0 487117.0 89651.0 92251.0 97306.0 97383.0 97424.5 885.6 897.3 927.0 928.2 1017.0 17800.3 18319.9 18486.6 18617.0 18655.0 36611.0 38541.8 43651.8 44711.6 44863.8 58543.4 62681.0 63520.0 64179.4 65525.0 8816.3 12198.3 12650.7 12719.9 13033.5 13229.4 13558.7 14227.7 14374.1 14406.9 12681.5 12835.9 12875.0 13113.4 13213.4 12670.5 12705.9 12865.0 13107.7 13296.5 13027.5 13206.3 13352.1 13393.0 13457.1 12912.3 13030.6 13231.1 13268.5 13336.9 13006.8 13014.2 13111.0 13176.9 13493.5 02:47:08 INFO - PROCESS | 25357 | 02:47:08 INFO - PROCESS | 25357 | [#3] mootools.html Cycles:180 Average:5693.76 Median:5311.51 stddev:3209.83 (60.4%) stddev-sans-first:3201.82 02:47:08 INFO - PROCESS | 25357 | Values: 1296.7 1421.7 1467.9 1594.3 1774.7 7514.9 8171.3 8443.2 8450.0 8664.8 8482.2 8543.7 8550.8 8554.6 8557.9 2291.4 2319.3 2321.1 2322.2 2324.9 2290.7 2319.5 2366.7 2370.7 2374.2 2299.8 2300.8 2317.1 2318.9 2325.2 2210.7 2219.6 2226.5 2226.8 2247.1 2059.7 2063.8 2072.2 2073.3 2255.6 8648.5 8694.0 8707.9 8724.6 8745.3 5262.7 5463.2 5471.9 5553.9 5574.7 3362.3 3427.7 3474.2 3531.7 3546.1 1094.4 1109.4 1117.2 1147.1 1148.3 11839.9 11947.2 12008.0 12057.0 12067.1 4359.8 4620.7 4687.8 4700.5 4717.2 9674.3 9713.8 9722.1 9740.5 9746.9 5420.7 5424.2 5425.2 5433.2 5434.5 4277.9 4423.4 4627.4 5052.2 5067.9 3748.4 3795.9 3874.7 3884.5 3888.6 1163.4 1192.5 1194.9 1197.2 1210.9 855.0 912.2 949.5 963.0 1015.1 5605.6 5791.8 5850.2 5882.0 6083.1 449.4 450.5 451.0 456.3 463.4 3969.2 4034.8 4051.4 4083.4 4122.8 10151.9 10866.9 10885.5 10894.0 10958.9 10131.3 10370.2 10695.5 10788.7 10842.9 7864.9 8040.2 8071.9 8079.4 8095.9 5958.8 6024.7 6047.2 6052.0 6111.8 9287.5 9811.5 9849.8 9857.2 9933.2 8629.2 8835.2 9704.1 10052.3 10079.3 7489.7 7670.0 7744.7 7845.8 7853.3 8540.7 8579.7 8636.0 8641.5 8643.6 7474.7 7581.5 7598.4 7700.7 7856.6 7322.3 7428.1 7464.2 7502.4 7733.2 6961.7 7099.3 7103.0 7104.0 7106.9 5307.4 5315.7 5317.6 5325.7 5507.9 5304.7 5335.0 5354.1 5367.7 5496.8 02:47:08 INFO - PROCESS | 25357 | 02:47:08 INFO - PROCESS | 25357 | [#4] prototype.html Cycles:180 Average:4662.96 Median:5210.53 stddev:1324.29 (25.4%) stddev-sans-first:1287.88 02:47:08 INFO - PROCESS | 25357 | Values: 352.9 368.1 373.3 376.0 377.6 5131.6 5269.3 5287.4 5290.5 5304.3 5075.5 5208.8 5247.0 5251.9 5253.6 4207.3 4217.5 4221.2 4241.2 4242.4 4076.7 4194.7 4205.3 4223.8 4236.6 4197.1 4203.3 4207.8 4210.4 4217.9 4185.5 4196.3 4197.2 4204.2 4218.3 3672.9 3771.4 3791.7 3801.7 3805.6 5119.9 5121.4 5138.9 5139.2 5149.2 4815.2 4816.3 4822.6 4825.6 4833.5 5303.3 5441.9 5457.7 5486.0 5509.6 4136.3 4159.4 4160.2 4161.9 4179.6 5601.7 5616.8 5659.4 5668.8 5679.0 4156.6 4238.3 4239.9 4248.6 4300.7 4300.9 4307.7 4324.3 4350.8 4361.6 4805.2 4814.6 4831.2 4862.2 4865.0 5367.4 5537.3 5583.4 5603.4 5638.1 1366.6 1393.4 1420.5 1435.5 1440.1 1008.9 1026.7 1032.2 1033.0 1045.9 5149.0 5190.0 5199.7 5204.2 5212.2 5390.7 5402.5 5410.5 5420.4 5446.2 5084.8 5175.2 5180.5 5192.0 5411.7 2871.6 2888.9 2891.6 2899.6 2912.9 5718.3 5732.5 5745.6 5771.6 5790.9 5389.8 5497.6 5514.6 5533.3 5536.6 5685.8 5689.9 5705.3 5709.7 5717.9 5326.9 5364.5 5459.8 5498.5 5506.8 5575.4 5613.2 5617.7 5627.8 5649.8 5918.4 5929.8 5950.5 6001.7 6012.1 3980.0 4137.1 4152.7 4175.5 4200.9 5433.0 5549.0 5658.0 5677.5 5686.7 5400.4 5538.0 5549.7 5561.7 5590.9 5482.9 5493.8 5516.6 5518.7 5524.4 5332.0 5459.4 5505.7 5505.7 5545.5 5475.5 5506.3 5536.7 5553.9 5557.6 5307.1 5435.0 5448.8 5451.9 5498.9 02:47:08 INFO - PROCESS | 25357 | 02:47:08 INFO - PROCESS | 25357 | [#5] yui.html Cycles:180 Average:17586.26 Median:4544.48 stddev:22278.62 (490.2%) stddev-sans-first:22305.16 02:47:08 INFO - PROCESS | 25357 | Values: 730.8 736.0 741.1 827.1 895.1 15169.8 15480.8 15708.5 15712.5 15747.3 14653.9 14789.4 15092.8 15885.3 15989.8 832.3 851.5 851.8 851.9 852.9 843.2 847.2 847.7 849.8 850.8 885.5 886.2 886.5 887.1 887.3 880.3 881.1 882.8 883.1 883.3 645.8 646.0 646.0 646.2 646.4 15798.6 15848.3 15896.2 15901.5 15969.4 13777.5 14096.4 14561.8 14670.4 14838.9 11989.2 12322.2 12470.3 12549.4 12806.6 3894.2 3918.8 3934.8 3967.0 4008.8 41295.6 47983.3 60904.1 65889.0 69056.3 11774.9 11959.1 12038.9 12113.6 12271.5 20867.7 20942.7 20963.2 21064.5 21091.3 8675.6 8736.5 8789.1 8794.1 8812.6 4617.9 4623.0 4702.2 4837.2 4853.5 3618.9 3677.1 3746.8 3751.2 3756.9 642.1 649.0 649.6 650.4 657.7 709.0 750.4 790.3 790.8 797.7 9772.4 9861.0 9907.8 10012.6 10042.4 681.6 734.3 746.4 791.4 805.1 4504.0 4585.0 4691.8 4950.9 4991.6 73132.6 74097.0 75985.2 82764.6 86137.0 70868.3 72438.6 72892.0 73282.3 73334.0 67929.3 69427.7 70322.0 72858.6 73464.6 9821.9 10384.1 10437.3 10457.6 10548.2 34213.0 39901.4 44020.0 46507.0 46541.1 57000.0 62938.0 65754.7 66520.0 67939.0 11777.8 12541.4 12650.2 12720.2 12773.9 13093.2 13106.7 13256.9 13445.4 14152.0 12516.3 12627.3 13076.5 13642.9 13749.1 12645.4 12663.7 13241.1 13577.3 13625.1 13148.3 13385.7 13527.2 13839.9 13919.2 10980.5 11009.7 11170.3 11379.2 11863.5 10230.0 11164.3 11339.1 11645.7 11817.2 02:47:08 INFO - PROCESS | 25357 | -------- Summary: end -------- 02:47:08 INFO - PROCESS | 25357 | 02:47:09 INFO - TEST-INFO | 25357: exit 0 02:47:09 INFO - TEST-OK | dromaeo_css | took 1114974ms 02:47:09 INFO - TEST-START | kraken 02:47:09 INFO - operating with platform_type : linux_ 02:47:09 INFO - Initialising browser for kraken test... 02:47:09 INFO - TEST-INFO | started process 25677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2VnCY7/profile http://localhost:45667/getInfo.html) 02:47:13 INFO - PROCESS | 25677 | __metrics Screen width/height:1600/1200 02:47:13 INFO - PROCESS | 25677 | colorDepth:24 02:47:13 INFO - PROCESS | 25677 | Browser inner width/height: 1024/697 02:47:13 INFO - PROCESS | 25677 | __metrics 02:47:13 INFO - PROCESS | 25677 | 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" 02:47:13 INFO - PROCESS | 25677 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:47:14 INFO - PROCESS | 25677 | console.error: PushService: 02:47:14 INFO - PROCESS | 25677 | stateChangeProcessEnqueue: Error transitioning state 02:47:14 INFO - PROCESS | 25677 | UnknownError 02:47:14 INFO - TEST-INFO | 25677: exit 0 02:47:14 INFO - Browser initialized. 02:47:14 INFO - Running cycle 1/1 for kraken test... 02:47:14 INFO - TEST-INFO | started process 25772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2VnCY7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:26 INFO - PROCESS | 25772 | RSS: Main: 144556032 02:47:26 INFO - PROCESS | 25772 | 02:47:29 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45667/tests/kraken/driver.html?testName=audio-beat-detection) 02:47:30 INFO - PROCESS | 25772 | RSS: Main: 185679872 02:47:30 INFO - PROCESS | 25772 | 02:47:32 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45667/tests/kraken/driver.html?testName=audio-dft) 02:47:33 INFO - PROCESS | 25772 | RSS: Main: 174997504 02:47:33 INFO - PROCESS | 25772 | 02:47:36 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45667/tests/kraken/driver.html?testName=audio-fft) 02:47:36 INFO - PROCESS | 25772 | RSS: Main: 266891264 02:47:36 INFO - PROCESS | 25772 | 02:47:38 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45667/tests/kraken/driver.html?testName=audio-oscillator) 02:47:39 INFO - PROCESS | 25772 | RSS: Main: 172470272 02:47:39 INFO - PROCESS | 25772 | 02:47:41 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45667/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:47:41 INFO - PROCESS | 25772 | RSS: Main: 175149056 02:47:41 INFO - PROCESS | 25772 | 02:47:44 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45667/tests/kraken/driver.html?testName=imaging-darkroom) 02:47:45 INFO - PROCESS | 25772 | RSS: Main: 214376448 02:47:45 INFO - PROCESS | 25772 | 02:47:48 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45667/tests/kraken/driver.html?testName=imaging-desaturate) 02:47:49 INFO - PROCESS | 25772 | RSS: Main: 213241856 02:47:49 INFO - PROCESS | 25772 | 02:47:52 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45667/tests/kraken/driver.html?testName=json-parse-financial) 02:47:52 INFO - PROCESS | 25772 | RSS: Main: 211582976 02:47:52 INFO - PROCESS | 25772 | 02:47:54 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45667/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:47:54 INFO - PROCESS | 25772 | RSS: Main: 173834240 02:47:54 INFO - PROCESS | 25772 | 02:47:56 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45667/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:47:57 INFO - PROCESS | 25772 | RSS: Main: 180682752 02:47:57 INFO - PROCESS | 25772 | 02:47:59 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45667/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:47:59 INFO - PROCESS | 25772 | RSS: Main: 189853696 02:47:59 INFO - PROCESS | 25772 | 02:48:02 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:02 INFO - PROCESS | 25772 | RSS: Main: 198590464 02:48:02 INFO - PROCESS | 25772 | 02:48:05 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:06 INFO - PROCESS | 25772 | RSS: Main: 194592768 02:48:06 INFO - PROCESS | 25772 | 02:48:07 INFO - PROCESS | 25772 | Cycle 1(1): loaded http://localhost:45667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45667/tests/kraken/driver.html?testName=ai-astar) 02:48:08 INFO - PROCESS | 25772 | RSS: Main: 245972992 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | __start_tp_report 02:48:08 INFO - PROCESS | 25772 | _x_x_mozilla_page_load 02:48:08 INFO - PROCESS | 25772 | _x_x_mozilla_page_load_details 02:48:08 INFO - PROCESS | 25772 | |i|pagename|runs| 02:48:08 INFO - PROCESS | 25772 | |0;ai-astar;102;110;110;108;111;109;110;111;110;111 02:48:08 INFO - PROCESS | 25772 | |1;audio-beat-detection;148;117;117;157;123;120;119;118;154;119 02:48:08 INFO - PROCESS | 25772 | |2;audio-dft;161;163;162;163;162;160;160;161;161;161 02:48:08 INFO - PROCESS | 25772 | |3;audio-fft;73;75;75;118;74;74;74;75;95;74 02:48:08 INFO - PROCESS | 25772 | |4;audio-oscillator;82;83;119;82;82;82;99;81;80;116 02:48:08 INFO - PROCESS | 25772 | |5;imaging-gaussian-blur;117;116;118;117;117;117;116;116;116;116 02:48:08 INFO - PROCESS | 25772 | |6;imaging-darkroom;147;145;146;146;146;146;146;146;146;147 02:48:08 INFO - PROCESS | 25772 | |7;imaging-desaturate;85;85;84;85;84;85;85;84;84;85 02:48:08 INFO - PROCESS | 25772 | |8;json-parse-financial;52;50;49;52;58;49;50;50;50;49 02:48:08 INFO - PROCESS | 25772 | |9;json-stringify-tinderbox;60;59;59;59;69;59;60;59;60;59 02:48:08 INFO - PROCESS | 25772 | |10;stanford-crypto-aes;74;80;75;74;74;74;75;75;74;74 02:48:08 INFO - PROCESS | 25772 | |11;stanford-crypto-ccm;123;128;129;129;121;121;127;119;167;134 02:48:08 INFO - PROCESS | 25772 | |12;stanford-crypto-pbkdf2;151;152;149;151;153;152;153;155;152;154 02:48:08 INFO - PROCESS | 25772 | |13;stanford-crypto-sha256-iterative;63;61;61;61;61;62;63;61;63;59 02:48:08 INFO - PROCESS | 25772 | __end_tp_report 02:48:08 INFO - PROCESS | 25772 | __start_cc_report 02:48:08 INFO - PROCESS | 25772 | _x_x_mozilla_cycle_collect,1634 02:48:08 INFO - PROCESS | 25772 | __end_cc_report 02:48:08 INFO - PROCESS | 25772 | __startTimestamp1483094888025__endTimestamp 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | ------- Summary: start ------- 02:48:08 INFO - PROCESS | 25772 | Number of tests: 14 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.70 (2.5%) stddev-sans-first:1.00 02:48:08 INFO - PROCESS | 25772 | Values: 102.0 110.0 110.0 108.0 111.0 109.0 110.0 111.0 110.0 111.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:121.50 stddev:16.65 (13.7%) stddev-sans-first:16.21 02:48:08 INFO - PROCESS | 25772 | Values: 148.0 117.0 117.0 157.0 123.0 120.0 119.0 118.0 154.0 119.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 02:48:08 INFO - PROCESS | 25772 | Values: 161.0 163.0 162.0 163.0 162.0 160.0 160.0 161.0 161.0 161.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#3] audio-fft Cycles:10 Average:80.70 Median:74.50 stddev:14.65 (19.7%) stddev-sans-first:15.27 02:48:08 INFO - PROCESS | 25772 | Values: 73.0 75.0 75.0 118.0 74.0 74.0 74.0 75.0 95.0 74.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.00 stddev:15.20 (18.5%) stddev-sans-first:15.80 02:48:08 INFO - PROCESS | 25772 | Values: 82.0 83.0 119.0 82.0 82.0 82.0 99.0 81.0 80.0 116.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 02:48:08 INFO - PROCESS | 25772 | Values: 117.0 116.0 118.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 02:48:08 INFO - PROCESS | 25772 | Values: 147.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 02:48:08 INFO - PROCESS | 25772 | Values: 85.0 85.0 84.0 85.0 84.0 85.0 85.0 84.0 84.0 85.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:50.00 stddev:2.73 (5.5%) stddev-sans-first:2.86 02:48:08 INFO - PROCESS | 25772 | Values: 52.0 50.0 49.0 52.0 58.0 49.0 50.0 50.0 50.0 49.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:59.50 stddev:3.09 (5.2%) stddev-sans-first:3.28 02:48:08 INFO - PROCESS | 25772 | Values: 60.0 59.0 59.0 59.0 69.0 59.0 60.0 59.0 60.0 59.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.50 stddev:1.85 (2.5%) stddev-sans-first:1.94 02:48:08 INFO - PROCESS | 25772 | Values: 74.0 80.0 75.0 74.0 74.0 74.0 75.0 75.0 74.0 74.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:128.50 stddev:13.87 (10.8%) stddev-sans-first:14.49 02:48:08 INFO - PROCESS | 25772 | Values: 123.0 128.0 129.0 129.0 121.0 121.0 127.0 119.0 167.0 134.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:152.50 stddev:1.69 (1.1%) stddev-sans-first:1.73 02:48:08 INFO - PROCESS | 25772 | Values: 151.0 152.0 149.0 151.0 153.0 152.0 153.0 155.0 152.0 154.0 02:48:08 INFO - PROCESS | 25772 | 02:48:08 INFO - PROCESS | 25772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.27 (2.1%) stddev-sans-first:1.22 02:48:08 INFO - PROCESS | 25772 | Values: 63.0 61.0 61.0 61.0 61.0 62.0 63.0 61.0 63.0 59.0 02:48:08 INFO - PROCESS | 25772 | -------- Summary: end -------- 02:48:08 INFO - PROCESS | 25772 | 02:48:09 INFO - TEST-INFO | 25772: exit 0 02:48:09 INFO - TEST-OK | kraken | took 59337ms 02:48:09 INFO - SUITE-END | took 1174s 02:48:09 INFO - Completed test suite (00:19:34) 02:48:09 INFO - javascript benchmark 02:48:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.563063986362, 3260.527223552586, 3274.2632907595794, 3294.407006738786, 3312.90061298161, 5470.370907345657, 5527.889442211163, 5539.196816461611, 5540.252065971093, 5553.916691249635, 5529.087700529408, 5565.860853478665, 5599.188117722928, 5623.80316688916, 5632.26780518532, 5042.924356134661, 5061.392632884059, 5082.872928176788, 5135.306733590974, 5166.405863325709, 4950.282209079682, 4971.05549945511, 5103.106956282654, 5150.9742451287875, 5157.6131790115705, 5000.324956130912, 5021.84934451967, 5049.040682270375, 5060.418051924021, 5062.341895553573, 5092.618053645972, 5120.974395128001, 5123.129068058439, 5189.766460509286, 5192.221166824968, 5002.824901128443, 5075.619328550373, 5140.228965655144, 5157.613179011551, 5186.325777648919, 5384.892302153974, 5441.891162176774, 5444.50999410051, 5453.918191227135, 5489.725513724298, 5895.4694077532795, 5905.852353691193, 5909.940900590982, 5998.1602575639445, 6000.33996260411, 6011.909821352683, 6021.849453763691, 6030.577859549833, 6046.0, 6048.971674815292, 5438.374586922515, 5468.72656367184, 5526.917096243559, 5567.137093750475, 5579.163125531203, 6050.727717252734, 6058.4244496772735, 6075.726592303268, 6087.878242435127, 6093.451589356979, 5838.678872662044, 5844.473997340175, 5852.326982396994, 5867.823965281048, 5871.647701137946, 5726.284214473191, 5791.681457519877, 5798.536117110621, 5872.530197584183, 5883.14694369314, 5913.29040515141, 5931.584789064724, 5932.970335148383, 5953.880922381528, 5954.196183515257, 5884.146798714162, 5923.348431672513, 5933.6736479493175, 5938.851528711817, 5953.226080609493, 4391.297392417198, 4448.955510444855, 4582.9770851146195, 4631.58315751584, 4637.976810115995, 4129.070959034193, 4163.188178305262, 4167.97916010418, 4174.749515029108, 4199.769012704331, 5793.304803423532, 5813.244278243801, 5814.0, 5828.388019258002, 5832.445917637902, 5794.420557944256, 5841.94158058414, 5916.408359164136, 6031.638101713911, 6043.123747056652, 5763.049096899049, 5830.591858569945, 5839.328477225174, 5852.385499522574, 5868.501177399969, 5230.424653288135, 5232.581393488512, 5233.267342571967, 5235.607329450307, 5239.161734122598, 6037.0, 6130.264368275657, 6282.528810339334, 6347.587406818542, 6360.586561873556, 5892.469677729025, 5897.67562784051, 5966.70166491665, 6045.6070355426755, 6057.606255593372, 6275.905861411991, 6326.272478664829, 6327.367263273636, 6328.367163283635, 6335.493160547053, 5895.351511333835, 5895.380984996686, 5896.911546326723, 5900.822975310747, 5929.407059294036, 5737.0, 5840.357560668408, 5895.587308888336, 5948.910766338595, 5951.58338916289, 5809.36097029318, 5849.736761845812, 5852.619579727304, 5876.500497457764, 5894.086416605433, 5854.2389489366105, 5860.472557469848, 5863.618864773776, 5867.471927526543, 5876.059830427112, 5648.378678345297, 5701.258836351248, 5706.914396283976, 5757.510611598061, 5769.624974376652, 5854.677992710442, 5857.062869940789, 5864.179014937998, 5879.941200587939, 5896.6756828374855, 5608.551315894801, 5653.293338332708, 5705.885882282248, 5714.314282285986, 5722.0], "value": 5510.550619260685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2882839692978, 614.066618739516, 624.9532033843312, 642.5116911147529, 666.0142988377198, 33329.33341333175, 44347.556524434745, 45560.3165952511, 45572.54427455724, 45596.772016139876, 45927.54072459274, 46231.30653040207, 46306.0, 46372.0, 46431.0, 8257.339412846957, 8814.86777698335, 8964.193222609963, 8967.596458159365, 8971.14774096463, 8277.503349799, 10478.790424191511, 10719.410432426213, 10743.677689669323, 11069.778604427907, 10505.68482945513, 10534.631287904887, 10559.947200263989, 10577.259591828575, 10581.84127238092, 10745.677629671123, 10768.084712799422, 10808.729781755519, 10812.405317707522, 10816.296940698829, 10680.25238233324, 10742.838857417146, 10760.78478430435, 10761.408122553257, 10767.353958762422, 43825.56174438247, 44072.55927440717, 44131.55868441339, 44138.0, 44190.33714494285, 3667.963320366789, 3700.85196592136, 3747.512823332949, 3864.632859878307, 4401.207782599131, 32538.0, 32818.12238297947, 33018.6698133018, 33281.83359083189, 33853.661463385295, 4075.551689314173, 4105.199486100211, 4150.875473735793, 4173.833046678129, 4242.278812601834, 367552.0, 368693.1565342183, 368752.0, 368815.0, 369223.0, 60867.695661522295, 61131.69434152801, 61246.0, 61253.38746612566, 61298.69350653218, 38557.228855422734, 40086.59913400887, 40276.79861600673, 43268.0, 43287.35068973968, 16819.32722691103, 16894.831051689573, 16952.74570881438, 16986.83013169877, 17010.404635837687, 12487.250764954131, 12815.487380504861, 13337.73324533504, 13814.309284535733, 13937.512187073404, 20487.69268460974, 20662.17351305961, 20695.379138625864, 20707.792922070887, 20839.374818755463, 7158.2125966143685, 7317.5609463432365, 7374.3363097320425, 7416.22129676387, 7493.66278517468, 1029.6705054382676, 1067.9305845120043, 1125.319181894958, 1127.9943600281947, 1152.0783373301326, 33332.666673332955, 33769.49345759815, 34018.829905850806, 34074.44862509512, 34126.146846329044, 999.4053538144792, 1113.87190473095, 1134.7390100276982, 1142.9028532574823, 1214.3078445286278, 16231.918840405722, 17978.0, 18075.186616602285, 18642.34751783681, 18765.43703688864, 564144.0, 566043.0, 566795.0, 567858.0, 569956.0, 59852.70073649604, 60478.395216047276, 60502.0, 60798.0, 60920.39079609236, 1264.563725514696, 1292.0309767674244, 1370.54086880896, 1388.125480946997, 1388.8402833674054, 29600.259993500335, 33095.834520828204, 34070.82964585161, 34218.292011566155, 34397.656023440446, 50905.236421452966, 51172.232416514526, 51453.48546514637, 51492.0, 51515.48484515257, 384982.0, 388931.0, 389012.0, 389673.0, 390056.0, 29274.0, 30800.69199307978, 31120.844395778782, 32439.02682919516, 32459.0, 47851.76074119607, 48598.75700621474, 48828.26757598568, 48919.75540122276, 49990.75004625099, 41293.58706412897, 41502.792486037375, 41848.790756047245, 43433.78283108564, 43754.124917500834, 41311.586884130775, 41445.79277103595, 42595.10733899151, 43118.35322470228, 43162.0, 42752.0, 43187.0, 43711.56288437075, 43846.56153438425, 43878.34182487201, 36009.639903601674, 37709.4343584841, 38383.23233535369, 38585.22829543337, 38819.41770873496, 28585.714142858305, 28725.42549149047, 28924.132276031753, 29010.709892900803, 29146.854265728536], "value": 20839.213206493674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.2152715718398, 435.86270324847675, 439.63290652305324, 440.82367053178734, 444.8954495693512, 17324.307027718893, 19819.108140133692, 20634.48413789656, 20691.172353105856, 20963.790362096395, 20070.29753958608, 20284.29004984826, 20321.288754893583, 20366.59266814663, 20548.794512054876, 5717.2281741964825, 5932.3474417814, 5933.495652869489, 5937.703114844262, 5938.46553810157, 5779.508741756956, 6041.667708276043, 6077.4530292273685, 6139.6009259398215, 6150.0, 6007.044253254362, 6101.847453813668, 6153.046277826944, 6168.0, 6171.814845554618, 6079.20970273866, 6174.567780255384, 6182.227221597301, 6183.072539119145, 6185.072239164117, 5794.0, 5986.0, 6008.3390827009, 6033.607815491979, 6041.879162416727, 14711.926440367837, 14961.0, 14965.925170374187, 22349.441263968532, 23679.526409471713, 2360.362702070431, 2384.582698027838, 2458.7172475165225, 2500.549901017816, 2971.7028297170327, 10820.458977051194, 10857.077148442391, 11168.106551475863, 11379.943100284445, 11420.942895285554, 1854.7496088028079, 1861.3206179744432, 1861.821221378603, 1885.6794344961252, 1939.5151212196952, 84319.15680843174, 86880.13119868847, 88338.55830720869, 88636.11363886343, 89958.6506202414, 10323.94838025805, 11856.110791690659, 11862.940685296518, 11969.247073173045, 12054.638360849189, 15442.0734755915, 15606.765898511305, 16399.590010249838, 16511.752323715154, 17127.914360428367, 7796.688132474637, 7856.057273127261, 7900.130985591581, 7946.284834364935, 8045.919540804517, 7083.7520686775715, 7088.432925365958, 7092.574445533284, 7265.782026539212, 7274.127104747358, 5100.413452452941, 5139.357580302462, 5151.047056294523, 5192.844214673566, 5270.0, 2049.610573990937, 2088.9764015632536, 2129.520857807012, 2131.4085765485206, 2151.5911976724374, 923.4320892650971, 964.4695417520336, 1012.7063151686076, 1056.894310568937, 1082.5074591061048, 19894.204231830856, 20049.198032078846, 20530.69203961942, 20531.0, 20561.280355187497, 984.4241118945497, 993.7118235711563, 1006.1950439648252, 1041.9895801042044, 1086.6631344283298, 10347.84478232812, 11406.714832129097, 11433.59982400612, 11518.769624607461, 11686.065114790796, 458672.0, 478204.0, 485156.0, 487006.0, 487117.0, 89651.0, 92251.0, 97306.0, 97383.0, 97424.51287743516, 885.6457417033109, 897.3225214962662, 926.9860952085725, 928.224932181636, 1017.0439786600572, 17800.287988480835, 18319.908400457913, 18486.630267394845, 18617.0, 18655.0, 36611.0, 38541.80729096449, 43651.781741091094, 44711.55288447204, 44863.775681121384, 58543.4145658538, 62681.0, 63520.0, 64179.35820641734, 65525.0, 8816.338774591803, 12198.268103913793, 12650.746985060063, 12719.87280127187, 13033.47866085346, 13229.40467678976, 13558.728825423634, 14227.715445691236, 14374.137551746928, 14406.855931440552, 12681.492740290285, 12835.93582032084, 12875.0, 13113.409896554487, 13213.405396757362, 12670.493180272686, 12705.936470317589, 12865.035122365673, 13107.672308192372, 13296.534621288209, 13027.47890084386, 13206.27365494907, 13352.132111412728, 13393.0, 13457.125286856322, 12912.289824059766, 13030.609081727564, 13231.139975901535, 13268.53560125391, 13336.866631333562, 13006.804897926728, 13014.15407998477, 13111.0, 13176.868231317947, 13493.460261589427], "value": 9763.667804850491, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.6563860576955, 1421.6872288096615, 1467.9412823487062, 1594.2985086561912, 1774.6894293498635, 7514.924850751498, 8171.264586187242, 8443.155684431555, 8449.957750211248, 8664.783380415493, 8482.194191551793, 8543.65825366986, 8550.828983420328, 8554.572271386436, 8557.91442085579, 2291.3584196424986, 2319.3042087373806, 2321.106374045996, 2322.222055611372, 2324.9186278480256, 2290.7365652949875, 2319.5013072189477, 2366.668666386707, 2370.7155141382973, 2374.2165085521824, 2299.827512936528, 2300.804431623314, 2317.1079134533156, 2318.8840557972117, 2325.2094287942095, 2210.7347118345742, 2219.6448568229166, 2226.510167763098, 2226.7661895501064, 2247.1460844878843, 2059.680749483832, 2063.8452116091353, 2072.1504183284783, 2073.3054426767053, 2255.57144142614, 8648.524331161783, 8693.956530217309, 8707.912920870773, 8724.563771811385, 8745.344099192585, 5262.657927234755, 5463.235147079412, 5471.890562188773, 5553.916691249635, 5574.693391863446, 3362.3107263011025, 3427.6915077642884, 3474.2009337852437, 3531.682148606638, 3546.148924258185, 1094.4254266510065, 1109.4397329348628, 1117.2235296468957, 1147.1224513247373, 1148.26511032939, 11839.881601183964, 11947.163698541019, 12008.0, 12057.0, 12067.094967877356, 4359.80380882861, 4620.653450991122, 4687.789049492781, 4700.529947005341, 4717.174494463455, 9674.322797404255, 9713.757156071155, 9722.125008749246, 9740.464274464972, 9746.853797193047, 5420.7289635518855, 5424.159255315432, 5425.186222066722, 5433.212184233343, 5434.456554344534, 4277.893052673708, 4423.402840616475, 4627.3521706961055, 5052.191649336162, 5067.8986420271385, 3748.4002559590335, 3795.9240815184094, 3874.6706529945272, 3884.533855937249, 3888.6111388860886, 1163.4124766992616, 1192.4872304908972, 1194.8506436695413, 1197.2457351868268, 1210.9091818113677, 854.9633445611304, 912.169925367912, 949.4967667136428, 962.9711108666751, 1015.0914931136591, 5605.607607467438, 5791.82624521265, 5850.151727999416, 5882.02946513829, 6083.148359229712, 449.3933190193278, 450.5179457979996, 450.99774501127285, 456.3086923311186, 463.3813858498942, 3969.2458432898234, 4034.838606455709, 4051.372037334218, 4083.448734420815, 4122.824994876446, 10151.94924025375, 10866.891331086747, 10885.510152043018, 10894.0, 10958.945205273923, 10131.341462804894, 10370.170386369073, 10695.465226738632, 10788.676339709822, 10842.891571084188, 7864.859595358641, 8040.150765324008, 8071.919280807234, 8079.353651707849, 8095.878561821577, 5958.791442299499, 6024.7288872001745, 6047.153398524122, 6052.0, 6111.816645500642, 9287.489188094449, 9811.509424528887, 9849.753756155867, 9857.211423086279, 9933.205343572352, 8629.180227878342, 8835.160659737314, 9704.126628603459, 10052.296339256181, 10079.34484258521, 7489.737859174903, 7670.0, 7744.65149068282, 7845.764627061198, 7853.2932036114735, 8540.701075462577, 8579.742607721779, 8635.956820215859, 8641.524716140673, 8643.56782160902, 7474.663640136316, 7581.469297149147, 7598.392128629807, 7700.691972321044, 7856.646450909609, 7322.267773222635, 7428.1086269647985, 7464.1789403166695, 7502.437317201341, 7733.226677332222, 6961.6519174042105, 7099.325564071405, 7103.041089452858, 7103.964480177566, 7106.857862842818, 5307.363116426053, 5315.654482458628, 5317.627766056339, 5325.653832500875, 5507.862303442285, 5304.7347632618985, 5335.0, 5354.143337066051, 5367.651102678314, 5496.763228273607], "value": 4484.523609920855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.8641473032882, 368.1495744829444, 373.33173619221594, 376.0485970494648, 377.61483287047196, 5131.563817075553, 5269.341332333458, 5287.39194992576, 5290.497402746738, 5304.257403963448, 5075.543201111899, 5208.817691380802, 5246.973765131179, 5251.894962100765, 5253.553447956919, 4207.263728847454, 4217.45173127493, 4221.24017676818, 4241.1941731071, 4242.406063151161, 4076.694247931417, 4194.685398595102, 4205.327147656376, 4223.788810559475, 4236.618704316611, 4197.139586384784, 4203.285441474956, 4207.831686732527, 4210.368444733299, 4217.882261200769, 4185.497740271172, 4196.349565817272, 4197.202531519017, 4204.2432362174795, 4218.261804184255, 3672.9081772955624, 3771.3588689922503, 3791.696664266852, 3801.6768574671187, 3805.56236032857, 5119.926429795939, 5121.385433747937, 5138.897222055575, 5139.17773156297, 5149.150390185615, 4815.194302136699, 4816.253480710496, 4822.63830212732, 4825.589824864891, 4833.492483289239, 5303.257543943812, 5441.945580544183, 5457.727113644341, 5485.985092757853, 5509.614326997112, 4136.296829538986, 4159.417681524589, 4160.167966406731, 4161.8554897403155, 4179.582041795827, 5601.719914004324, 5616.775328986836, 5659.434056594308, 5668.829935101953, 5678.971605141948, 4156.625903668684, 4238.279492486285, 4239.936400953989, 4248.553901840262, 4300.677449191323, 4300.9247688077985, 4307.698461107755, 4324.2648749712625, 4350.825966961286, 4361.563843615613, 4805.231163013971, 4814.555633309993, 4831.154547954094, 4862.17343051682, 4864.951350486521, 5367.382750983609, 5537.280153580089, 5583.357913839879, 5603.411641777636, 5638.069718496402, 1366.5763613279914, 1393.3869097597026, 1420.4673247532176, 1435.5478024422273, 1440.1143296872558, 1008.9243306751877, 1026.6714651311509, 1032.1587905856702, 1032.963846265377, 1045.926785125034, 5148.995945790535, 5190.0, 5199.66202196856, 5204.21936709489, 5212.244224587489, 5390.679283575549, 5402.51377376038, 5410.540104091117, 5420.376656684453, 5446.21029950655, 5084.796608135707, 5175.171972484384, 5180.456052114474, 5191.97404012985, 5411.729413529308, 2871.6410448693914, 2888.942221155565, 2891.6096326995585, 2899.594056832045, 2912.8689208985647, 5718.285214348207, 5732.512736417451, 5745.626534275259, 5771.567132465082, 5790.917403230712, 5389.83830485086, 5497.587680923867, 5514.5864060194845, 5533.253010843485, 5536.612437129363, 5685.829425117253, 5689.857753556194, 5705.343885453143, 5709.687576531512, 5717.885642287214, 5326.866828329323, 5364.490373414519, 5459.781608735606, 5498.51540084167, 5506.752196151103, 5575.351707938858, 5613.214150018919, 5617.736009397853, 5627.803026894039, 5649.830505084854, 5918.378570250062, 5929.822105336847, 5950.523958083257, 6001.749343996002, 6012.070102515895, 3980.0049987503126, 4137.13120244752, 4152.730072545275, 4175.519815221289, 4200.873973780792, 5432.972835135799, 5549.0, 5657.971710141423, 5677.51741102011, 5686.687232202103, 5400.351957765093, 5538.0, 5549.72251387421, 5561.6663000220115, 5590.888182236251, 5482.890342193214, 5493.807716729895, 5516.641418307797, 5518.668879867221, 5524.447555244444, 5331.973340133274, 5459.441366458893, 5505.697186654773, 5505.724713764215, 5545.500904918576, 5475.534579560782, 5506.284183056177, 5536.7231638418725, 5553.916691249715, 5557.5553955682635, 5307.097793375213, 5435.0, 5448.809291674931, 5451.918221226605, 5498.945010550004], "value": 4253.983180801973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.83556199855, 735.9595222262774, 741.0847603210035, 827.1397746343803, 895.1183084661607, 15169.848301516995, 15480.845191548095, 15708.52874413768, 15712.528624141294, 15747.291371888265, 14653.92673036636, 14789.408423663068, 15092.773608395883, 15885.285162167702, 15989.84010159898, 832.334132693844, 851.5018714052287, 851.8381507513584, 851.8764779107025, 852.910444403338, 843.2242337049898, 847.2205570874779, 847.7456762971115, 849.7748096754334, 850.8255807559435, 885.5262434597491, 886.1979908183105, 886.5124181700071, 887.1084560017174, 887.3477993674644, 880.295763389286, 881.1452890696047, 882.7969566999626, 883.1080608585343, 883.2713011765287, 645.8191706322191, 645.961242325462, 646.0277282689569, 646.205167643796, 646.4279112985042, 15798.605034874105, 15848.286827092808, 15896.205189740582, 15901.522954311273, 15969.441069562627, 13777.517786877512, 14096.365663545164, 14561.78157327641, 14670.413183472649, 14838.851611483962, 11989.160758746892, 12322.199057061262, 12470.314132722697, 12549.372531373394, 12806.615801525875, 3894.1627550076587, 3918.8236529355963, 3934.803259836997, 3966.960330396717, 4008.7594744315434, 41295.587044129476, 47983.28025079626, 60904.08643870345, 65889.0, 69056.30943690549, 11774.882251177378, 11959.103067269989, 12038.879611203776, 12113.576024839089, 12271.509139634314, 20867.686984695243, 20942.685859712117, 20963.161473541193, 21064.473388165417, 21091.261805836722, 8675.609597568124, 8736.475811451333, 8789.077146899612, 8794.120587941155, 8812.559372031374, 4617.8845528861375, 4623.0, 4702.177119004161, 4837.177679794443, 4853.514648535189, 3618.945715814265, 3677.0807298175455, 3746.83139258734, 3751.174741556853, 3756.9436458453147, 642.142739442849, 648.9935100649028, 649.6232185332495, 650.388634683396, 657.6810247030187, 709.0357114324618, 750.3771869348428, 790.3203245209115, 790.8220650353625, 797.696875187425, 9772.413655180711, 9860.950695246478, 9907.789189594394, 10012.649557265606, 10042.447665378328, 681.57401623985, 734.2840730288033, 746.4140649590046, 791.3985371117992, 805.0822062848357, 4503.954960450419, 4585.0, 4691.786126503356, 4950.877853892635, 4991.550760431579, 73132.63433682904, 74097.0, 75985.24014759892, 82764.58617706873, 86137.0, 70868.2913170872, 72438.63780681063, 72892.0, 73282.26717732755, 73334.0, 67929.30176745522, 69427.65286173536, 70322.0, 72858.63570682112, 73464.63267683734, 9821.852672210065, 10384.065434110966, 10437.32157409766, 10457.633982810565, 10548.156147508027, 34213.0, 39901.40147897842, 44020.0, 46507.0, 46541.06917861691, 57000.0, 62938.0, 65754.67122664356, 66520.0, 67939.0, 11777.823332649845, 12541.372931353579, 12650.177738446971, 12720.236785792882, 12773.87226127764, 13093.214407135602, 13106.737865242832, 13256.867431325563, 13445.394957226752, 14152.0, 12516.311602861566, 12627.305498197687, 13076.476940922257, 13642.93178534101, 13749.106308089942, 12645.430955607204, 12663.746725065632, 13241.11262819025, 13577.32113394346, 13625.114367566473, 13148.276844773247, 13385.732285354043, 13527.188368697909, 13839.930800345934, 13919.164850109026, 10980.450977451255, 11009.724756881142, 11170.27393219438, 11379.158844909414, 11863.525458981545, 10229.980162092603, 11164.274322169033, 11339.149563782914, 11645.708857278636, 11817.231879927776], "value": 7368.0612280824425, "unit": "score"}], "name": "dromaeo_css", "value": 7349.65599353966, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 108.0, 111.0, 109.0, 110.0, 111.0, 110.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 117.0, 157.0, 123.0, 120.0, 119.0, 118.0, 154.0, 119.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 163.0, 162.0, 160.0, 160.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 118.0, 74.0, 74.0, 74.0, 75.0, 95.0, 74.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 119.0, 82.0, 82.0, 82.0, 99.0, 81.0, 80.0, 116.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 49.0, 52.0, 58.0, 49.0, 50.0, 50.0, 50.0, 49.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 69.0, 59.0, 60.0, 59.0, 60.0, 59.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 75.0, 74.0, 74.0, 74.0, 75.0, 75.0, 74.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 128.0, 129.0, 129.0, 121.0, 121.0, 127.0, 119.0, 167.0, 134.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 149.0, 151.0, 153.0, 152.0, 153.0, 155.0, 152.0, 154.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 61.0, 61.0, 62.0, 63.0, 61.0, 63.0, 59.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1448.0, "alertThreshold": 2.0}]} 02:48:09 INFO - Return code: 0 02:48:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:09 INFO - # TBPL SUCCESS # 02:48:09 INFO - Running post-action listener: _resource_record_post_action 02:48:09 INFO - [mozharness: 2016-12-30 10:48:09.325197Z] Finished run-tests step (success) 02:48:09 INFO - Running post-run listener: _resource_record_post_run 02:48:09 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345518080; Read time: 8; Write time: 285344 02:48:09 INFO - TinderboxPrint: CPU usage
13.0% 02:48:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:48:09 INFO - TinderboxPrint: I/O write bytes / time
345,518,080 / 285,344 02:48:09 INFO - TinderboxPrint: CPU idle
8,265.0 (87.0%) 02:48:09 INFO - TinderboxPrint: CPU user
1,190.0 (12.5%) 02:48:09 INFO - TinderboxPrint: Swap in / out
0 / 0 02:48:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108138496; Read time: 0; Write time: 122264 02:48:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 237031424; Read time: 0; Write time: 163076 02:48:09 INFO - Running post-run listener: _upload_blobber_files 02:48:09 INFO - Blob upload gear active. 02:48:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48:09 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 02:48:09 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'] 02:48:09 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 02:48:10 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:48:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:48:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:11 INFO - (blobuploader) - INFO - Done attempting. 02:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:48:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:12 INFO - (blobuploader) - INFO - Done attempting. 02:48:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:48:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:48:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:15 INFO - (blobuploader) - INFO - Done attempting. 02:48:15 INFO - (blobuploader) - INFO - Iteration through files over. 02:48:15 INFO - Return code: 0 02:48:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:48:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:48:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f3422247df3d102a026f60e5f8b4cea5743d5584ab2053701e0be822c3a6c43706b4c32651681c2e776a432fb2f6c17cc9930712c143532c025c25da9b8e945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa47a624ff48d2dda82bb68bebd00dca7fd8d7b279cd0427e2a3a30bc43c04769a5d4d7022e4d87ca51c0b711299243dc2a8ac73fa2eec67299a2823b43a09c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2ecaf234771a1886b1dee41b86d56be2435547cf9776f8844270721f4a531b05270e1e3baca0fc890516c65fb695611a28e322269fc0a1e025f852d7d61c4c"} 02:48:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:48:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:48:15 INFO - Contents: 02:48:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f3422247df3d102a026f60e5f8b4cea5743d5584ab2053701e0be822c3a6c43706b4c32651681c2e776a432fb2f6c17cc9930712c143532c025c25da9b8e945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa47a624ff48d2dda82bb68bebd00dca7fd8d7b279cd0427e2a3a30bc43c04769a5d4d7022e4d87ca51c0b711299243dc2a8ac73fa2eec67299a2823b43a09c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2ecaf234771a1886b1dee41b86d56be2435547cf9776f8844270721f4a531b05270e1e3baca0fc890516c65fb695611a28e322269fc0a1e025f852d7d61c4c"} 02:48:15 INFO - Running post-run listener: copy_logs_to_upload_dir 02:48:15 INFO - Copying logs to upload dir... 02:48:15 INFO - mkdir: /builds/slave/test/build/upload/logs 02:48:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.775165 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-30 02:48:15.071070) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 02:48:15.078027) ========= 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=62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309 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/3f3422247df3d102a026f60e5f8b4cea5743d5584ab2053701e0be822c3a6c43706b4c32651681c2e776a432fb2f6c17cc9930712c143532c025c25da9b8e945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa47a624ff48d2dda82bb68bebd00dca7fd8d7b279cd0427e2a3a30bc43c04769a5d4d7022e4d87ca51c0b711299243dc2a8ac73fa2eec67299a2823b43a09c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2ecaf234771a1886b1dee41b86d56be2435547cf9776f8844270721f4a531b05270e1e3baca0fc890516c65fb695611a28e322269fc0a1e025f852d7d61c4c"} build_url:https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/WYzwtxtFT2-8Ff6--Y4rRQ/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/3f3422247df3d102a026f60e5f8b4cea5743d5584ab2053701e0be822c3a6c43706b4c32651681c2e776a432fb2f6c17cc9930712c143532c025c25da9b8e945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa47a624ff48d2dda82bb68bebd00dca7fd8d7b279cd0427e2a3a30bc43c04769a5d4d7022e4d87ca51c0b711299243dc2a8ac73fa2eec67299a2823b43a09c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2ecaf234771a1886b1dee41b86d56be2435547cf9776f8844270721f4a531b05270e1e3baca0fc890516c65fb695611a28e322269fc0a1e025f852d7d61c4c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 02:48:15.103011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:48:15.103365) ========= 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=62c568580acbfdaac3eec7be000001dc-1483093659.887918-115534309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 02:48:15.189361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 02:48:15.191465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 02:48:15.191770) ========= ========= Total master_lag: 0.19 =========