builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1483160222.53 results: success (0) buildid: 20161230190220 builduid: e6d332bc669d42d8ab859e5e04d61e41 revision: 907b98f8c6fadbcad27e1c13c7d3645bc1109368 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:02.533621) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:02.534201) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:02.534540) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:02.552705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:02.553017) ========= 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=0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 20:57:02-- 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% 113M=0s 2016-12-30 20:57:03 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:02.664420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:02.664796) ========= 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=0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015020 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:02.715091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:02.715474) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 907b98f8c6fadbcad27e1c13c7d3645bc1109368 --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 907b98f8c6fadbcad27e1c13c7d3645bc1109368 --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=0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 20:57:03,157 truncating revision to first 12 chars 2016-12-30 20:57:03,158 Setting DEBUG logging. 2016-12-30 20:57:03,158 attempt 1/10 2016-12-30 20:57:03,158 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/907b98f8c6fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 20:57:03,478 unpacking tar archive at: mozilla-aurora-907b98f8c6fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:03.367616) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:03.367929) ========= script_repo_revision: 907b98f8c6fadbcad27e1c13c7d3645bc1109368 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:03.368407) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:03.371711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 20:57:03.382619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-30 20:57:03.382918) ========= /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=0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:57:03 INFO - MultiFileLogger online at 20161230 20:57:03 in /builds/slave/test 20:57:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:57:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:57:03 INFO - {'append_to_log': False, 20:57:03 INFO - 'base_work_dir': '/builds/slave/test', 20:57:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:57:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:57:03 INFO - 'branch': 'Mozilla-Aurora', 20:57:03 INFO - 'buildbot_json_path': 'buildprops.json', 20:57:03 INFO - 'config_files': ('talos/linux_config.py',), 20:57:03 INFO - 'default_actions': ('clobber', 20:57:03 INFO - 'read-buildbot-config', 20:57:03 INFO - 'download-and-extract', 20:57:03 INFO - 'populate-webroot', 20:57:03 INFO - 'create-virtualenv', 20:57:03 INFO - 'install', 20:57:03 INFO - 'run-tests'), 20:57:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:57:03 INFO - 'download_minidump_stackwalk': True, 20:57:03 INFO - 'download_symbols': 'ondemand', 20:57:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:57:03 INFO - 'tooltool.py': '/tools/tooltool.py', 20:57:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:57:03 INFO - '/tools/misc-python/virtualenv.py')}, 20:57:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:57:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:57:03 INFO - 'installer_path': 'installer.exe', 20:57:03 INFO - 'log_level': 'info', 20:57:03 INFO - 'log_name': 'talos', 20:57:03 INFO - 'log_to_console': True, 20:57:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:57:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:57:03 INFO - 'opt_config_files': (), 20:57:03 INFO - 'pip_index': False, 20:57:03 INFO - 'sps_profile': False, 20:57:03 INFO - 'sps_profile_interval': 0, 20:57:03 INFO - 'suite': 'dromaeojs', 20:57:03 INFO - 'system_bits': '32', 20:57:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:57:03 INFO - 'title': 'talos-linux64-ix-058', 20:57:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:57:03 INFO - 'use_talos_json': True, 20:57:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:57:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:57:03 INFO - 'work_dir': 'build'} 20:57:03 INFO - [mozharness: 2016-12-31 04:57:03.918507Z] Running clobber step. 20:57:03 INFO - Running pre-action listener: _resource_record_pre_action 20:57:03 INFO - Running main action method: clobber 20:57:03 INFO - rmtree: /builds/slave/test/build 20:57:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:57:04 INFO - Running post-action listener: _resource_record_post_action 20:57:04 INFO - [mozharness: 2016-12-31 04:57:04.908074Z] Finished clobber step (success) 20:57:04 INFO - [mozharness: 2016-12-31 04:57:04.908173Z] Running read-buildbot-config step. 20:57:04 INFO - Running pre-action listener: _resource_record_pre_action 20:57:04 INFO - Running main action method: read_buildbot_config 20:57:04 INFO - Using buildbot properties: 20:57:04 INFO - { 20:57:04 INFO - "project": "", 20:57:04 INFO - "product": "firefox", 20:57:04 INFO - "script_repo_revision": "production", 20:57:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:57:04 INFO - "repository": "", 20:57:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 20:57:04 INFO - "buildid": "20161230190220", 20:57:04 INFO - "pgo_build": "True", 20:57:04 INFO - "basedir": "/builds/slave/test", 20:57:04 INFO - "buildnumber": 702, 20:57:04 INFO - "slavename": "talos-linux64-ix-058", 20:57:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:57:04 INFO - "platform": "ubuntu64_hw", 20:57:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:57:04 INFO - "branch": "mozilla-aurora", 20:57:04 INFO - "repo_path": "releases/mozilla-aurora", 20:57:04 INFO - "revision": "907b98f8c6fadbcad27e1c13c7d3645bc1109368", 20:57:04 INFO - "stage_platform": "linux64-pgo", 20:57:04 INFO - "builduid": "e6d332bc669d42d8ab859e5e04d61e41", 20:57:04 INFO - "slavebuilddir": "test" 20:57:04 INFO - } 20:57:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 20:57:04 INFO - Running post-action listener: _resource_record_post_action 20:57:04 INFO - [mozharness: 2016-12-31 04:57:04.910892Z] Finished read-buildbot-config step (success) 20:57:04 INFO - [mozharness: 2016-12-31 04:57:04.910982Z] Running download-and-extract step. 20:57:04 INFO - Running pre-action listener: _resource_record_pre_action 20:57:04 INFO - Running main action method: download_and_extract 20:57:04 INFO - mkdir: /builds/slave/test/build/tests 20:57: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')]} 20:57:04 INFO - trying https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:57:04 INFO - Downloading https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:57:05 INFO - Downloaded 1361 bytes. 20:57:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 20:57:05 INFO - Using the following test package requirements: 20:57:05 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 20:57:05 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:57:05 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:57:05 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:57:05 INFO - u'jsshell-linux-x86_64.zip'], 20:57:05 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:57:05 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 20:57:05 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:57:05 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:57:05 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:57:05 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 20:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:57:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:57:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 20:57:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:57:05 INFO - Fetch https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:57:06 INFO - Http code: 200 20:57:06 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 20:57:06 INFO - x-amz-cf-id: 8cFsD1WAels1rSlVFH--0IADP5CrmlEAUN8qHkvgs85q25G-DXq9aA== 20:57:06 INFO - x-amz-version-id: lctUN3v4cExw3xJh65ysiXZzjMz60ues 20:57:06 INFO - Expected file size: 21941199 20:57:06 INFO - Obtained file size: 21941199 20:57:10 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:57:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 20:57:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:57:10 INFO - Fetch https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:57:10 INFO - Http code: 200 20:57:10 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 20:57:10 INFO - x-amz-cf-id: jxEX_mRfiaFfqvO0B4q9pqvTlCaP8hubcezKYpMP4ZachmMA_Sdxkw== 20:57:10 INFO - x-amz-version-id: lctUN3v4cExw3xJh65ysiXZzjMz60ues 20:57:11 INFO - Expected file size: 21941199 20:57:11 INFO - Obtained file size: 21941199 20:57:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 20:57:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:57:15 INFO - Fetch https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 20:57:16 INFO - Http code: 200 20:57:16 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 20:57:16 INFO - x-amz-cf-id: QiabVcGkw-ZtB1kk11ONCobPfpqMHATNbmwP4QlUUmZ82X9go35YmA== 20:57:16 INFO - x-amz-version-id: ZkcU8OABavyVrLlo1HtlDkbkU_Pli8LM 20:57:16 INFO - Expected file size: 14409038 20:57:16 INFO - Obtained file size: 14409038 20:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:16 INFO - trying https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:57:16 INFO - Downloading https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:57:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:57:17 INFO - Downloaded 64005639 bytes. 20:57:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:57:17 INFO - mkdir: /builds/slave/test/properties 20:57:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:57:17 INFO - Writing to file /builds/slave/test/properties/build_url 20:57:17 INFO - Contents: 20:57:17 INFO - build_url:https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 20:57:18 INFO - Running post-action listener: _resource_record_post_action 20:57:18 INFO - Running post-action listener: set_extra_try_arguments 20:57:18 INFO - [mozharness: 2016-12-31 04:57:18.377423Z] Finished download-and-extract step (success) 20:57:18 INFO - [mozharness: 2016-12-31 04:57:18.377656Z] Running populate-webroot step. 20:57:18 INFO - Running pre-action listener: _resource_record_pre_action 20:57:18 INFO - Running main action method: populate_webroot 20:57:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:57:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:57:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:57:18 INFO - '--tppagecycles', 20:57:18 INFO - '7'], 20:57:18 INFO - 'tests': ['tsvgm']}}, 20:57:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:57:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:57:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:57:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:57:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:18 INFO - 'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:18 INFO - 'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['damp', 'tps']}, 20:57:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:18 INFO - 'tests': ['damp', 'tps']}, 20:57:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['dromaeo_dom']}, 20:57:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:57:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['basic_compositor_video']}, 20:57:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:57:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['a11yr', 20:57:18 INFO - 'ts_paint', 20:57:18 INFO - 'tpaint', 20:57:18 INFO - 'sessionrestore', 20:57:18 INFO - 'sessionrestore_no_auto_restore', 20:57:18 INFO - 'tabpaint']}, 20:57:18 INFO - 'other-e10s': {'tests': ['a11yr', 20:57:18 INFO - 'ts_paint', 20:57:18 INFO - 'tpaint', 20:57:18 INFO - 'sessionrestore', 20:57:18 INFO - 'sessionrestore_no_auto_restore', 20:57:18 INFO - 'tabpaint']}, 20:57:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:57:18 INFO - 'ts_paint', 20:57:18 INFO - 'tpaint', 20:57:18 INFO - 'sessionrestore', 20:57:18 INFO - 'sessionrestore_no_auto_restore', 20:57:18 INFO - 'tabpaint']}, 20:57:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:57:18 INFO - 'ts_paint', 20:57:18 INFO - 'tpaint', 20:57:18 INFO - 'sessionrestore', 20:57:18 INFO - 'sessionrestore_no_auto_restore', 20:57:18 INFO - 'tabpaint']}, 20:57:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['a11yr', 20:57:18 INFO - 'ts_paint', 20:57:18 INFO - 'tpaint', 20:57:18 INFO - 'sessionrestore', 20:57:18 INFO - 'sessionrestore_no_auto_restore', 20:57:18 INFO - 'tabpaint']}, 20:57:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['a11yr', 20:57:18 INFO - 'ts_paint', 20:57:18 INFO - 'tpaint', 20:57:18 INFO - 'sessionrestore', 20:57:18 INFO - 'sessionrestore_no_auto_restore', 20:57:18 INFO - 'tabpaint']}, 20:57:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['tsvgx', 20:57:18 INFO - 'tsvgr_opacity', 20:57:18 INFO - 'tart', 20:57:18 INFO - 'tscrollx', 20:57:18 INFO - 'cart']}, 20:57:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:57:18 INFO - 'tsvgr_opacity', 20:57:18 INFO - 'tart', 20:57:18 INFO - 'tscrollx', 20:57:18 INFO - 'cart']}, 20:57:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:18 INFO - 'talos_options': ['--disable-e10s'], 20:57:18 INFO - 'tests': ['tp5o']}, 20:57:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:18 INFO - 'tests': ['tp5o']}, 20:57:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:18 INFO - 'talos_options': ['--disable-e10s', 20:57:18 INFO - '--xperf_path', 20:57:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:18 INFO - 'tests': ['tp5n']}, 20:57:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:57:18 INFO - 'talos_options': ['--xperf_path', 20:57:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:18 INFO - 'tests': ['tp5n']}}, 20:57:18 INFO - 'talos.zip': {'path': '', 20:57:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:57:18 INFO - Running post-action listener: _resource_record_post_action 20:57:18 INFO - [mozharness: 2016-12-31 04:57:18.394138Z] Finished populate-webroot step (success) 20:57:18 INFO - [mozharness: 2016-12-31 04:57:18.394226Z] Running create-virtualenv step. 20:57:18 INFO - Running pre-action listener: _resource_record_pre_action 20:57:18 INFO - Running main action method: create_virtualenv 20:57:18 INFO - Creating virtualenv /builds/slave/test/build/venv 20:57:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:57:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:57:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:57:18 INFO - Using real prefix '/usr' 20:57:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:57:19 INFO - Installing distribute.............................................................................................................................................................................................done. 20:57:20 INFO - Installing pip.................done. 20:57:20 INFO - Return code: 0 20:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:57:21 INFO - Reading from file tmpfile_stdout 20:57:21 INFO - Output received: 20:57:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:57:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:57:21 INFO - Using env: {'DISPLAY': ':0', 20:57:21 INFO - 'HOME': '/home/cltbld', 20:57:21 INFO - 'LANG': 'en_US.UTF-8', 20:57:21 INFO - 'LANGUAGE': 'en_US:en', 20:57:21 INFO - 'LOGNAME': 'cltbld', 20:57:21 INFO - 'MAIL': '/var/mail/cltbld', 20:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:21 INFO - 'MOZ_NO_REMOTE': '1', 20:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:21 INFO - 'NO_EM_RESTART': '1', 20:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:21 INFO - 'PWD': '/builds/slave/test', 20:57:21 INFO - 'SHELL': '/bin/bash', 20:57:21 INFO - 'SHLVL': '1', 20:57:21 INFO - 'TERM': 'linux', 20:57:21 INFO - 'TMOUT': '86400', 20:57:21 INFO - 'USER': 'cltbld', 20:57:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:21 INFO - '_': '/tools/buildbot/bin/python'} 20:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:57:21 INFO - Cleaning up... 20:57:21 INFO - Return code: 0 20:57:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:57:21 INFO - Using env: {'DISPLAY': ':0', 20:57:21 INFO - 'HOME': '/home/cltbld', 20:57:21 INFO - 'LANG': 'en_US.UTF-8', 20:57:21 INFO - 'LANGUAGE': 'en_US:en', 20:57:21 INFO - 'LOGNAME': 'cltbld', 20:57:21 INFO - 'MAIL': '/var/mail/cltbld', 20:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:21 INFO - 'MOZ_NO_REMOTE': '1', 20:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:21 INFO - 'NO_EM_RESTART': '1', 20:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:21 INFO - 'PWD': '/builds/slave/test', 20:57:21 INFO - 'SHELL': '/bin/bash', 20:57:21 INFO - 'SHLVL': '1', 20:57:21 INFO - 'TERM': 'linux', 20:57:21 INFO - 'TMOUT': '86400', 20:57:21 INFO - 'USER': 'cltbld', 20:57:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:21 INFO - '_': '/tools/buildbot/bin/python'} 20:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:21 INFO - Downloading/unpacking psutil>=3.1.1 20:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:57:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:23 INFO - Installing collected packages: psutil 20:57:23 INFO - Running setup.py install for psutil 20:57:23 INFO - building 'psutil._psutil_linux' extension 20:57:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:57:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:57:23 INFO - building 'psutil._psutil_posix' extension 20:57:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:57:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:24 INFO - Successfully installed psutil 20:57:24 INFO - Cleaning up... 20:57:24 INFO - Return code: 0 20:57:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:57:24 INFO - Using env: {'DISPLAY': ':0', 20:57:24 INFO - 'HOME': '/home/cltbld', 20:57:24 INFO - 'LANG': 'en_US.UTF-8', 20:57:24 INFO - 'LANGUAGE': 'en_US:en', 20:57:24 INFO - 'LOGNAME': 'cltbld', 20:57:24 INFO - 'MAIL': '/var/mail/cltbld', 20:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:24 INFO - 'MOZ_NO_REMOTE': '1', 20:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:24 INFO - 'NO_EM_RESTART': '1', 20:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:24 INFO - 'PWD': '/builds/slave/test', 20:57:24 INFO - 'SHELL': '/bin/bash', 20:57:24 INFO - 'SHLVL': '1', 20:57:24 INFO - 'TERM': 'linux', 20:57:24 INFO - 'TMOUT': '86400', 20:57:24 INFO - 'USER': 'cltbld', 20:57:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:24 INFO - '_': '/tools/buildbot/bin/python'} 20:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:57:26 INFO - Installing collected packages: mozsystemmonitor 20:57:26 INFO - Running setup.py install for mozsystemmonitor 20:57:26 INFO - Successfully installed mozsystemmonitor 20:57:26 INFO - Cleaning up... 20:57:26 INFO - Return code: 0 20:57:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:26 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 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:57:26 INFO - Using env: {'DISPLAY': ':0', 20:57:26 INFO - 'HOME': '/home/cltbld', 20:57:26 INFO - 'LANG': 'en_US.UTF-8', 20:57:26 INFO - 'LANGUAGE': 'en_US:en', 20:57:26 INFO - 'LOGNAME': 'cltbld', 20:57:26 INFO - 'MAIL': '/var/mail/cltbld', 20:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:26 INFO - 'MOZ_NO_REMOTE': '1', 20:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:26 INFO - 'NO_EM_RESTART': '1', 20:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:26 INFO - 'PWD': '/builds/slave/test', 20:57:26 INFO - 'SHELL': '/bin/bash', 20:57:26 INFO - 'SHLVL': '1', 20:57:26 INFO - 'TERM': 'linux', 20:57:26 INFO - 'TMOUT': '86400', 20:57:26 INFO - 'USER': 'cltbld', 20:57:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:26 INFO - '_': '/tools/buildbot/bin/python'} 20:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:26 INFO - Downloading/unpacking jsonschema==2.5.1 20:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:57:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:29 INFO - Downloading functools32-3.2.3-2.tar.gz 20:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:57:29 INFO - warning: no files found matching '*.txt' 20:57:29 INFO - no previously-included directories found matching 'build' 20:57:29 INFO - no previously-included directories found matching 'dist' 20:57:29 INFO - no previously-included directories found matching '.git*' 20:57:29 INFO - Installing collected packages: jsonschema, functools32 20:57:29 INFO - Running setup.py install for functools32 20:57:29 INFO - warning: no files found matching '*.txt' 20:57:29 INFO - no previously-included directories found matching 'build' 20:57:29 INFO - no previously-included directories found matching 'dist' 20:57:29 INFO - no previously-included directories found matching '.git*' 20:57:29 INFO - Successfully installed jsonschema functools32 20:57:29 INFO - Cleaning up... 20:57:29 INFO - Return code: 0 20:57:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:29 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 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:57:29 INFO - Using env: {'DISPLAY': ':0', 20:57:29 INFO - 'HOME': '/home/cltbld', 20:57:29 INFO - 'LANG': 'en_US.UTF-8', 20:57:29 INFO - 'LANGUAGE': 'en_US:en', 20:57:29 INFO - 'LOGNAME': 'cltbld', 20:57:29 INFO - 'MAIL': '/var/mail/cltbld', 20:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:29 INFO - 'MOZ_NO_REMOTE': '1', 20:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:29 INFO - 'NO_EM_RESTART': '1', 20:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:29 INFO - 'PWD': '/builds/slave/test', 20:57:29 INFO - 'SHELL': '/bin/bash', 20:57:29 INFO - 'SHLVL': '1', 20:57:29 INFO - 'TERM': 'linux', 20:57:29 INFO - 'TMOUT': '86400', 20:57:29 INFO - 'USER': 'cltbld', 20:57:29 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:29 INFO - '_': '/tools/buildbot/bin/python'} 20:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:57:29 INFO - Cleaning up... 20:57:29 INFO - Return code: 0 20:57:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:29 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 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:57:29 INFO - Using env: {'DISPLAY': ':0', 20:57:29 INFO - 'HOME': '/home/cltbld', 20:57:29 INFO - 'LANG': 'en_US.UTF-8', 20:57:29 INFO - 'LANGUAGE': 'en_US:en', 20:57:29 INFO - 'LOGNAME': 'cltbld', 20:57:29 INFO - 'MAIL': '/var/mail/cltbld', 20:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:29 INFO - 'MOZ_NO_REMOTE': '1', 20:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:29 INFO - 'NO_EM_RESTART': '1', 20:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:29 INFO - 'PWD': '/builds/slave/test', 20:57:29 INFO - 'SHELL': '/bin/bash', 20:57:29 INFO - 'SHLVL': '1', 20:57:29 INFO - 'TERM': 'linux', 20:57:29 INFO - 'TMOUT': '86400', 20:57:29 INFO - 'USER': 'cltbld', 20:57:29 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:29 INFO - '_': '/tools/buildbot/bin/python'} 20:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:29 INFO - Downloading/unpacking blobuploader==1.2.4 20:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:31 INFO - Downloading blobuploader-1.2.4.tar.gz 20:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:57:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:57:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:32 INFO - Downloading docopt-0.6.1.tar.gz 20:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:57:32 INFO - Installing collected packages: blobuploader, requests, docopt 20:57:32 INFO - Running setup.py install for blobuploader 20:57:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:57:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:57:32 INFO - Running setup.py install for requests 20:57:33 INFO - Running setup.py install for docopt 20:57:33 INFO - Successfully installed blobuploader requests docopt 20:57:33 INFO - Cleaning up... 20:57:33 INFO - Return code: 0 20:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:57:33 INFO - Using env: {'DISPLAY': ':0', 20:57:33 INFO - 'HOME': '/home/cltbld', 20:57:33 INFO - 'LANG': 'en_US.UTF-8', 20:57:33 INFO - 'LANGUAGE': 'en_US:en', 20:57:33 INFO - 'LOGNAME': 'cltbld', 20:57:33 INFO - 'MAIL': '/var/mail/cltbld', 20:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:33 INFO - 'MOZ_NO_REMOTE': '1', 20:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:33 INFO - 'NO_EM_RESTART': '1', 20:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:33 INFO - 'PWD': '/builds/slave/test', 20:57:33 INFO - 'SHELL': '/bin/bash', 20:57:33 INFO - 'SHLVL': '1', 20:57:33 INFO - 'TERM': 'linux', 20:57:33 INFO - 'TMOUT': '86400', 20:57:33 INFO - 'USER': 'cltbld', 20:57:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:33 INFO - '_': '/tools/buildbot/bin/python'} 20:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:33 INFO - Running setup.py (path:/tmp/pip-QC7EML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:33 INFO - Running setup.py (path:/tmp/pip-MO5bUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:33 INFO - Running setup.py (path:/tmp/pip-GmmSB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:33 INFO - Running setup.py (path:/tmp/pip-1ABijS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:33 INFO - Running setup.py (path:/tmp/pip-yR1fs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:33 INFO - Running setup.py (path:/tmp/pip-KwDu1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:33 INFO - Running setup.py (path:/tmp/pip-iHjJia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:34 INFO - Running setup.py (path:/tmp/pip-bBQdeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:34 INFO - Running setup.py (path:/tmp/pip-yT3DQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:34 INFO - Running setup.py (path:/tmp/pip-3rTHPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:34 INFO - Running setup.py (path:/tmp/pip-Rj98bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:34 INFO - Running setup.py (path:/tmp/pip-xc9qoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:34 INFO - Running setup.py (path:/tmp/pip-UCjfMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:34 INFO - Running setup.py (path:/tmp/pip-URPWGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:34 INFO - Running setup.py (path:/tmp/pip-43rwgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:34 INFO - Running setup.py (path:/tmp/pip-Ex0dAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:34 INFO - Running setup.py (path:/tmp/pip-5HOZzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:57:34 INFO - Running setup.py install for manifestparser 20:57:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:57:34 INFO - Running setup.py install for mozcrash 20:57:34 INFO - Running setup.py install for mozdebug 20:57:35 INFO - Running setup.py install for mozdevice 20:57:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Running setup.py install for mozfile 20:57:35 INFO - Running setup.py install for mozhttpd 20:57:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Running setup.py install for mozinfo 20:57:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Running setup.py install for mozInstall 20:57:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Running setup.py install for mozleak 20:57:35 INFO - Running setup.py install for mozlog 20:57:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Running setup.py install for moznetwork 20:57:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:57:35 INFO - Running setup.py install for mozprocess 20:57:36 INFO - Running setup.py install for mozprofile 20:57:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Running setup.py install for mozrunner 20:57:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Running setup.py install for mozscreenshot 20:57:36 INFO - Running setup.py install for moztest 20:57:36 INFO - Running setup.py install for mozversion 20:57:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:57:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:57:36 INFO - Cleaning up... 20:57:36 INFO - Return code: 0 20:57:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:36 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 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:57:36 INFO - Using env: {'DISPLAY': ':0', 20:57:36 INFO - 'HOME': '/home/cltbld', 20:57:36 INFO - 'LANG': 'en_US.UTF-8', 20:57:36 INFO - 'LANGUAGE': 'en_US:en', 20:57:36 INFO - 'LOGNAME': 'cltbld', 20:57:36 INFO - 'MAIL': '/var/mail/cltbld', 20:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:36 INFO - 'MOZ_NO_REMOTE': '1', 20:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:36 INFO - 'NO_EM_RESTART': '1', 20:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:36 INFO - 'PWD': '/builds/slave/test', 20:57:36 INFO - 'SHELL': '/bin/bash', 20:57:36 INFO - 'SHLVL': '1', 20:57:36 INFO - 'TERM': 'linux', 20:57:36 INFO - 'TMOUT': '86400', 20:57:36 INFO - 'USER': 'cltbld', 20:57:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:36 INFO - '_': '/tools/buildbot/bin/python'} 20:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:36 INFO - Running setup.py (path:/tmp/pip-0LEBg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:36 INFO - Running setup.py (path:/tmp/pip-GPfHqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:36 INFO - Running setup.py (path:/tmp/pip-rMYt5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:37 INFO - Running setup.py (path:/tmp/pip-bc1aTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:37 INFO - Running setup.py (path:/tmp/pip-CY86C7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:37 INFO - Running setup.py (path:/tmp/pip-KzOiGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:37 INFO - Running setup.py (path:/tmp/pip-2MG1ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:37 INFO - Running setup.py (path:/tmp/pip-IvSVQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:37 INFO - Running setup.py (path:/tmp/pip-wsFRK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:37 INFO - Running setup.py (path:/tmp/pip-Dqtytg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:37 INFO - Running setup.py (path:/tmp/pip-1_3FIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:37 INFO - Running setup.py (path:/tmp/pip-R7tuDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:37 INFO - Running setup.py (path:/tmp/pip-2TgrSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:37 INFO - Running setup.py (path:/tmp/pip-P0CdW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:37 INFO - Running setup.py (path:/tmp/pip-mEdcAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:37 INFO - Running setup.py (path:/tmp/pip-KrjgIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:38 INFO - Running setup.py (path:/tmp/pip-9IB03B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:57:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:40 INFO - Downloading blessings-1.6.tar.gz 20:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:57:40 INFO - Installing collected packages: blessings 20:57:40 INFO - Running setup.py install for blessings 20:57:40 INFO - Successfully installed blessings 20:57:40 INFO - Cleaning up... 20:57:40 INFO - Return code: 0 20:57:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:40 INFO - Reading from file tmpfile_stdout 20:57:40 INFO - Current package versions: 20:57:40 INFO - argparse == 1.2.1 20:57:40 INFO - blessings == 1.6 20:57:40 INFO - blobuploader == 1.2.4 20:57:40 INFO - docopt == 0.6.1 20:57:40 INFO - functools32 == 3.2.3-2 20:57:40 INFO - jsonschema == 2.5.1 20:57:40 INFO - manifestparser == 1.1 20:57:40 INFO - mozInstall == 1.12 20:57:40 INFO - mozcrash == 1.0 20:57:40 INFO - mozdebug == 0.1 20:57:40 INFO - mozdevice == 0.48 20:57:40 INFO - mozfile == 1.2 20:57:40 INFO - mozhttpd == 0.7 20:57:40 INFO - mozinfo == 0.9 20:57:40 INFO - mozleak == 0.1 20:57:40 INFO - mozlog == 3.4 20:57:40 INFO - moznetwork == 0.27 20:57:40 INFO - mozprocess == 0.23 20:57:40 INFO - mozprofile == 0.28 20:57:40 INFO - mozrunner == 6.13 20:57:40 INFO - mozscreenshot == 0.1 20:57:40 INFO - mozsystemmonitor == 0.3 20:57:40 INFO - moztest == 0.7 20:57:40 INFO - mozversion == 1.4 20:57:40 INFO - psutil == 3.1.1 20:57:40 INFO - requests == 1.2.3 20:57:40 INFO - wsgiref == 0.1.2 20:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:40 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 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:57:40 INFO - Using env: {'DISPLAY': ':0', 20:57:40 INFO - 'HOME': '/home/cltbld', 20:57:40 INFO - 'LANG': 'en_US.UTF-8', 20:57:40 INFO - 'LANGUAGE': 'en_US:en', 20:57:40 INFO - 'LOGNAME': 'cltbld', 20:57:40 INFO - 'MAIL': '/var/mail/cltbld', 20:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:40 INFO - 'MOZ_NO_REMOTE': '1', 20:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:40 INFO - 'NO_EM_RESTART': '1', 20:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:40 INFO - 'PWD': '/builds/slave/test', 20:57:40 INFO - 'SHELL': '/bin/bash', 20:57:40 INFO - 'SHLVL': '1', 20:57:40 INFO - 'TERM': 'linux', 20:57:40 INFO - 'TMOUT': '86400', 20:57:40 INFO - 'USER': 'cltbld', 20:57:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:40 INFO - '_': '/tools/buildbot/bin/python'} 20:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:57:40 INFO - Cleaning up... 20:57:40 INFO - Return code: 0 20:57:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e50395f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, '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': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:57:40 INFO - Using env: {'DISPLAY': ':0', 20:57:40 INFO - 'HOME': '/home/cltbld', 20:57:40 INFO - 'LANG': 'en_US.UTF-8', 20:57:40 INFO - 'LANGUAGE': 'en_US:en', 20:57:40 INFO - 'LOGNAME': 'cltbld', 20:57:40 INFO - 'MAIL': '/var/mail/cltbld', 20:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:40 INFO - 'MOZ_NO_REMOTE': '1', 20:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:40 INFO - 'NO_EM_RESTART': '1', 20:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:40 INFO - 'PWD': '/builds/slave/test', 20:57:40 INFO - 'SHELL': '/bin/bash', 20:57:40 INFO - 'SHLVL': '1', 20:57:40 INFO - 'TERM': 'linux', 20:57:40 INFO - 'TMOUT': '86400', 20:57:40 INFO - 'USER': 'cltbld', 20:57:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:40 INFO - '_': '/tools/buildbot/bin/python'} 20:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:57:41 INFO - Cleaning up... 20:57:41 INFO - Return code: 0 20:57:41 INFO - Running post-action listener: _resource_record_post_action 20:57:41 INFO - Running post-action listener: _start_resource_monitoring 20:57:41 INFO - Starting resource monitoring. 20:57:41 INFO - [mozharness: 2016-12-31 04:57:41.059487Z] Finished create-virtualenv step (success) 20:57:41 INFO - [mozharness: 2016-12-31 04:57:41.059954Z] Running install step. 20:57:41 INFO - Running pre-action listener: _resource_record_pre_action 20:57:41 INFO - Running main action method: install 20:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:41 INFO - Reading from file tmpfile_stdout 20:57:41 INFO - Detecting whether we're running mozinstall >=1.0... 20:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:57:41 INFO - Reading from file tmpfile_stdout 20:57:41 INFO - Output received: 20:57:41 INFO - Usage: mozinstall [options] installer 20:57:41 INFO - Options: 20:57:41 INFO - -h, --help show this help message and exit 20:57:41 INFO - -d DEST, --destination=DEST 20:57:41 INFO - Directory to install application into. [default: 20:57:41 INFO - "/builds/slave/test"] 20:57:41 INFO - --app=APP Application being installed. [default: firefox] 20:57:41 INFO - mkdir: /builds/slave/test/build/application 20:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:57:57 INFO - Reading from file tmpfile_stdout 20:57:57 INFO - Output received: 20:57:57 INFO - /builds/slave/test/build/application/firefox/firefox 20:57:57 INFO - Running post-action listener: _resource_record_post_action 20:57:57 INFO - [mozharness: 2016-12-31 04:57:57.302781Z] Finished install step (success) 20:57:57 INFO - [mozharness: 2016-12-31 04:57:57.303029Z] Running run-tests step. 20:57:57 INFO - Running pre-action listener: _resource_record_pre_action 20:57:57 INFO - Running main action method: run_tests 20:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:57:57 INFO - Python 2.7.3 20:57:57 INFO - Return code: 0 20:57:57 INFO - grabbing minidump binary from tooltool 20:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d4f60>, '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 0x26d5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:57:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:57:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:57:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:57:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:57:57 INFO - Return code: 0 20:57:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:57:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:57:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:57:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:57:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:57:57 INFO - Using env: {'DISPLAY': ':0', 20:57:57 INFO - 'HOME': '/home/cltbld', 20:57:57 INFO - 'LANG': 'en_US.UTF-8', 20:57:57 INFO - 'LANGUAGE': 'en_US:en', 20:57:57 INFO - 'LOGNAME': 'cltbld', 20:57:57 INFO - 'MAIL': '/var/mail/cltbld', 20:57:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:57:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:57 INFO - 'MOZ_NO_REMOTE': '1', 20:57:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:57 INFO - 'NO_EM_RESTART': '1', 20:57:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:57 INFO - 'PWD': '/builds/slave/test', 20:57:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:57:57 INFO - 'SHELL': '/bin/bash', 20:57:57 INFO - 'SHLVL': '1', 20:57:57 INFO - 'TERM': 'linux', 20:57:57 INFO - 'TMOUT': '86400', 20:57:57 INFO - 'USER': 'cltbld', 20:57:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346', 20:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:57 INFO - '_': '/tools/buildbot/bin/python'} 20:57:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:57:57 INFO - mozversion application_buildid: 20161230190220 20:57:57 INFO - mozversion application_changeset: 907b98f8c6fadbcad27e1c13c7d3645bc1109368 20:57:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:57:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:57:57 INFO - mozversion application_name: Firefox 20:57:57 INFO - mozversion application_remotingname: firefox-dev 20:57:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:57:57 INFO - mozversion application_vendor: Mozilla 20:57:57 INFO - mozversion application_version: 52.0a2 20:57:57 INFO - mozversion platform_buildid: 20161230190220 20:57:57 INFO - mozversion platform_changeset: 907b98f8c6fadbcad27e1c13c7d3645bc1109368 20:57:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:57:57 INFO - mozversion platform_version: 52.0a2 20:57:57 INFO - using testdate: 1483160277 20:57:57 INFO - actual date: 1483160277 20:57:57 INFO - starting webserver on 'localhost:40130' 20:57:57 INFO - SUITE-START | Running 2 tests 20:57:57 INFO - TEST-START | dromaeo_css 20:57:57 INFO - operating with platform_type : linux_ 20:57:57 INFO - Initialising browser for dromaeo_css test... 20:57:57 INFO - TEST-INFO | started process 8724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpurtH5L/profile http://localhost:40130/getInfo.html) 20:58:01 INFO - PROCESS | 8724 | __metrics Screen width/height:1600/1200 20:58:01 INFO - PROCESS | 8724 | colorDepth:24 20:58:01 INFO - PROCESS | 8724 | Browser inner width/height: 1024/697 20:58:01 INFO - PROCESS | 8724 | __metrics 20:58:02 INFO - PROCESS | 8724 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:58:02 INFO - PROCESS | 8724 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:58:02 INFO - PROCESS | 8724 | console.error: PushService: 20:58:02 INFO - PROCESS | 8724 | stateChangeProcessEnqueue: Error transitioning state 20:58:02 INFO - PROCESS | 8724 | UnknownError 20:58:03 INFO - TEST-INFO | 8724: exit 0 20:58:03 INFO - Browser initialized. 20:58:03 INFO - Running cycle 1/1 for dromaeo_css test... 20:58:03 INFO - TEST-INFO | started process 8821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpurtH5L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:58:14 INFO - PROCESS | 8821 | RSS: Main: 145051648 20:58:14 INFO - PROCESS | 8821 | 20:59:06 INFO - PROCESS | 8821 | 1483160346517 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] 21:01:16 INFO - PROCESS | 8821 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40130/tests/dromaeo/cssquery-ext.html) 21:01:17 INFO - PROCESS | 8821 | RSS: Main: 242774016 21:01:17 INFO - PROCESS | 8821 | 21:04:20 INFO - PROCESS | 8821 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-ext.html (next: http://localhost:40130/tests/dromaeo/cssquery-jquery.html) 21:04:21 INFO - PROCESS | 8821 | RSS: Main: 225243136 21:04:21 INFO - PROCESS | 8821 | 21:07:23 INFO - PROCESS | 8821 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40130/tests/dromaeo/cssquery-mootools.html) 21:07:23 INFO - PROCESS | 8821 | RSS: Main: 203448320 21:07:23 INFO - PROCESS | 8821 | 21:10:25 INFO - PROCESS | 8821 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40130/tests/dromaeo/cssquery-prototype.html) 21:10:26 INFO - PROCESS | 8821 | RSS: Main: 217571328 21:10:26 INFO - PROCESS | 8821 | 21:13:28 INFO - PROCESS | 8821 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40130/tests/dromaeo/cssquery-yui.html) 21:13:29 INFO - PROCESS | 8821 | RSS: Main: 177573888 21:13:29 INFO - PROCESS | 8821 | 21:16:31 INFO - PROCESS | 8821 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-yui.html (next: http://localhost:40130/tests/dromaeo/cssquery-dojo.html) 21:16:32 INFO - PROCESS | 8821 | RSS: Main: 265768960 21:16:32 INFO - PROCESS | 8821 | 21:16:32 INFO - PROCESS | 8821 | __start_tp_report 21:16:32 INFO - PROCESS | 8821 | _x_x_mozilla_page_load 21:16:32 INFO - PROCESS | 8821 | _x_x_mozilla_page_load_details 21:16:32 INFO - PROCESS | 8821 | |i|pagename|runs| 21:16:32 INFO - PROCESS | 8821 | |0;dojo.html;3175.3490534440434;3179.7297229735464;3201.647818739938;3216.1477208539727;3243.935121297574;5413.648112872661;5495.422980587035;5499.450054994499;5508.7796488140475;5514.393416724157;5515.172724091388;5546.667199968005;5550.417206193352;5569.944300556993;5589.329280486337;5025.698458092517;5045.293658887758;5070.923936140961;5076.314697515843;5137.023965446553;4895.681780684262;5077.339945807058;5124.8975020499565;5129.53834154926;5134.204198349262;4891.730954797485;4946.579540739023;5023.924641130386;5051.444341122474;5051.924221136685;5002.699838009713;5029.1450453423;5043.823466178666;5109.284700141983;5139.254808052811;4943.085529177078;5011.1481048221885;5059.822906198302;5077.847664570068;5083.79664813407;5300.602454815866;5369.892602147975;5380.300560927094;5460.372057213432;5501.257330260443;5781.479666830005;5790.7394167262155;5799.130130480462;5897.8230653080045;5908;5944.881102377928;5959.880802383971;5960.105984102376;5966.940330596725;5968.612040217372;5395.649282796606;5426.321709786316;5479.6164268500825;5521.475459831309;5523.806666766724;6035.456808887221;6065.96967015171;6070.3019152798;6072.05883088122;6079.300880398722;5837.854053648693;5840.707964601753;5841.50347220491;5847.766089356463;5855.443732845373;5657.971710141505;5704.543636509069;5773.509251713567;5813.6221145625395;5820.447057529528;5859.707014649251;5861.706914654335;5862.882742345129;5884.499817515473;5896.204012458264;5809.506191973645;5860.062390017662;5869.647821130746;5872.706364681749;5874;4438.334249862546;4477.6417886569;4546.090781843578;4567.1550763108935;4598.655100867449;4081.4490043844294;4118.5263694674895;4135.048938744106;4138.91722165555;4162.354835000579;5654.547636189095;5670.404607516234;5677.886442271131;5681.460261275172;5683.460071293221;5728.598998070095;5733.9965506037115;5804.88390232193;5989.101634754735;5993.880122397615;5439.972800135974;5510.173473978855;5516.089845175501;5528.944710552923;5539.695316757617;5069.340985671839;5070.036693028313;5071.670341427795;5072.847814565569;5089.083964886356;5880.970595146997;6010.098485227163;6020.909686354796;6022.909656355158;6023.668698221552;5815.244018277597;5825.970870145622;5845.035569131046;5916.704164791657;5943.673097979479;6143.201383820075;6145.539084568764;6145.84635384119;6146.661933593696;6150.538709596887;5658;5809.767609295581;5824.70876456167;5825.94174058254;5827.9708601458415;5815.360310365941;5903.350631430625;5939.138824870456;5952.702364881825;6022.548308876764;5848.53211743051;5851.824445266649;5852.239208902815;5854.326752423526;5856.648601083949;5737.225474560881;5872.354041055566;5874.060150375919;5876.118582212703;5880.353161152184;5504.889902201853;5549.139883318092;5660.264165658438;5682.545396368363;5692;5845.912311315419;5850.5027072699295;5852.297724273115;5858.677772722541;5869.148973398918;5346.625736198429;5406.486383793534;5568.55451563882;5571.860703482445;5582.916256256078 21:16:32 INFO - PROCESS | 8821 | |1;ext.html;587.4976894754984;620.6865532905882;622.7571247213587;653.2030922274826;659.7690808217121;33490.66509334909;36745.448818267745;44596.77701611495;45158;45204.32193517092;46751.76624116875;47182.292265616044;47191;47215.527844721626;47227.29159062608;8205.343572514184;8780.209781119682;8926.910730892672;8928.285737141014;8928.55357232139;8167.877481837748;10577.894221057806;10822.945885270563;10828.40443775592;11123.666290011313;10799.460026998659;10852.565897364097;10858.619948301812;10863.51114199863;10867.673969780919;10673.519691613896;10700.357978521275;10741.946290268577;10766.515506802212;10773.084287835543;10571;10626.681199564026;10627.628033018884;10627.946860265727;10632.362058276529;43243.567564324585;43355;43574.56425435737;43582.78208608968;43644.345334819685;3610.259896721192;3693.445983102529;3918.784466854322;4050;4324.329728892027;32242.51636225435;32924.6707532924;33146.50280245774;33177.6682233177;33385.833070834735;3920.627540383659;4089.5297040840387;4124.566920473367;4199.391088292181;4218.156368726267;340929;343876;346906;347626;347920;60750.696246518484;60798.39201608016;60855.695721521995;60892.695536522035;60902.39097608967;39387.40918886219;40186.598134018874;40189.1962160761;42469.787651061546;42675;14959.77560336574;15180;15193.848061519464;15206.771898421532;15212;10265.435401052864;10345;11047.060999815105;11144.721381965353;11218.943905280421;19686.507837303896;20342.49143771388;20400;20620.48448788762;20622.690659640117;7316.378107860785;7336.596487193149;7369.299916507923;7396.9260307396235;7664.540127592362;965.666844938495;1019.169376957777;1034.9896501035043;1059.502034043998;1110.8000559899297;33649.83175084109;34414.48378274328;34715.65284347175;34827.651723482944;34911.65088349135;1039.9584016639249;1081.7331658391613;1114.1309778372881;1116.9497372618252;1188.869224385317;16024.679506409806;18227.362042328456;18364;18684.159212835453;19080.332188373617;588440;588587;589286;590464;593152;63640;63993;64010;64011;64065;1308.2150709574369;1327.8406591208923;1371.8559551247174;1388.5001399496173;1429.4067961795947;32637;35295;35317.29365412729;35716.107097321736;35730.10674733153;52277;52675.736621316646;52768.472315276354;52866.47133528616;52918.735406322725;341759;342468;342636;344070;838688;45365.31952020656;45620.087598247184;47343.763281183376;47498;48340.51659483501;51937.22094168515;52750.47249527455;52780;52793.73603132113;53175.46824531705;44307.55692443034;44660;45094;45113;45808.541914580426;45715.31427028664;45850.93670784756;45997.54002459932;46072.308915366964;46171.41717164187;45435;45498;45583.54416455926;45952.77023614861;46359.536404635524;37645.81177094206;39737.60262397339;40669;40825.442826091676;41105.1778964413;30252.394952100396;30642.846785765927;30673.38653226878;30786.230344241572;30872 21:16:32 INFO - PROCESS | 8821 | |2;jquery.html;390.5072144972096;430.16547897079664;438.26590460977854;442.4690371554135;448.88104652267134;16463.588410289733;19149.755265907705;20088.196472141117;20109.59780804383;20289.797102028977;19557.511062223453;20102.195912163497;20145;20225.595488090228;20388.286409975655;5712.685802280873;5917.40825917407;5923.88152236955;5929.644221346733;5932.080527518242;5588.636738611997;5829.533637309027;5855.941440585603;5858.912116318259;5859.0625499920025;5622;5845.970770146165;5849.356570777211;5850.6782126983;5852.648841069528;5726.484616384525;5823.56323275756;5825.1844741736195;5826.067829147316;5827.708614569276;5089.9745501272255;5233.581313494949;5245.711485868275;5246;5246.134387826004;23133.074677013068;23495.88252058746;23501;23663.881680591658;23900.641490377657;2352.6471029345735;2389.880505974694;2390.378501589582;2518.748125187485;3008.74425673818;14744.705105897821;14901.552953411307;15190.164540950243;15269.61825954349;15316.693666126615;1949.6393167264102;1974.5261137327082;1988.363723608446;2005.7693365263035;2035.9209618902005;84104.57947710222;85451.57274213652;85904.57047714783;87531;88324;9841.753956151153;10754.139668826476;10986.450677466095;11022.559097636165;11280.097592192606;14304;14458;15482.30329635169;15502.922485387726;16204.108774017306;7446.7712827382875;7618.5809780462605;7628.847423051508;7631.580263085472;7643.961780191064;7040.119985001875;7086.114235720535;7090.078289822393;7120.9349288706735;7265.4187664986675;6805.795826125224;6832.726690932307;6891.345322194384;6899.448044156456;6915.343042410963;1996.5208349996187;2029.4723371923405;2038.2560365466795;2068.8758674479277;2082.5938941906484;994.4232345239743;1018.9519066676035;1045.2160879340495;1049.3074570783247;1105.6517197082894;19168.904155479133;19606.607867842562;19684.803151968583;20294.797052029586;20606.27878024262;1009.6869970309081;1044.681372181492;1051.5320682296458;1090.8363745438248;1100.818364969771;11091.667249982513;11488;11549.595764148382;11688;11704.297742135499;495696;500581;530799.1140398692;539070;544305;83653;88046.11953880379;88998.55500722455;89030;89812.5509372449;1024.7130803375067;1052.6052730226165;1053.657561292583;1054.6361505280665;1063.4363787192801;17314.65370692604;17726.379576714753;18067.728984064986;18186.45440636783;18270.817291827443;42297.365539517545;42426.575734242266;42470;42699.57300426956;42736.78631606822;53578.041769881966;55038.449615503334;55497;56384;56747.71626141843;8848.778780530538;8858;8987.505687187268;9015.549222538715;9021.413608115452;9728.610855565697;13228.933855330662;13382.063255572017;13403.731925361242;13707.931460343034;12002.699932501757;12070.215435996632;12150.635480935585;12380.566680166152;12521.436535355748;11365.147613928822;11633.360165190996;11648;11877.406129693654;11998.820017699916;6614.90077648826;12063.155579109729;12066.457009434773;12243.510259589517;12951.611451656465;8925.285977121945;8995.95502022512;9000.774980625274;9120.133587309196;9335.113164249386;11674.883251167379;11740.765184696087;12147.453364598437;12233.3271670059;12273.263604183778 21:16:32 INFO - PROCESS | 8821 | |3;mootools.html;1321.9074664773464;1351.4391527516082;1416.7945647881058;1456.9271536423175;1824.051493223523;7632.961835190823;8326.625301861422;8545.102764209754;8600.56997150143;8899.332550058756;8673.479591224532;8681.26209272211;8732.8690069649;8738.475691458518;8744.737657870273;2331.079223706635;2359.740428552858;2360.303710405426;2361.055577768889;2363.8463499872455;2188.2122435923056;2218.256883943881;2325.1164557468137;2329.184785325131;2331.265651319837;2122.7028216049766;2125.5005073807642;2133.445304220906;2146.2380854796556;2168.642174041281;2233.8101261392803;2248.067052173346;2249.0778780699916;2265.3430505153488;2267.297137887252;2107.7681455039933;2118.1739121742535;2125.5961367340155;2128.968065479019;2131.5736852629534;8618.138186181332;8734.912650873473;8745;8758.036615972238;8816.779580510474;5129.153689641204;5305.098133317345;5310;5380.946190538084;5404.5946554008215;3233.87064517419;3248.3665685191395;3259.08745551246;3299.373119107362;3312.453445181542;944.8629948657475;949.6581230756922;959.6785076999214;973.109604711688;1030.598066753959;10844.783104337868;11168.776624467546;11214.607488737855;11844.052475801915;12033.097517686208;4509.751963641966;4619.23782575878;4741.336212930192;4765.785539650724;4768.713877167381;9544.665936692183;9550.331476796697;9557.569909354095;9559.091886270931;9559.90440095604;5233.947660523422;5269.657472264291;5271.947280527223;5273.2617433559335;5285.207218917117;4381.824727010884;4515.593596576324;4868.464468908417;4928.260760885896;5033.874153146127;3929.214157168578;4025.5571887092397;4063.756174629532;4109.239790638741;4118.670506359484;1266.183311763907;1341.215388997428;1357.7827547592337;1363.3251540487522;1368.8015237790464;965.3238954944879;984.8128855517429;1002.4937406609615;1011.079917275276;1023.7542989682422;5699.772009119672;5860.384659610765;5923.289205295306;6014.278286605635;6094.6647934363145;458.5712358944398;460.6591122569275;462.19577934393914;982.9557669904872;1069.6737495063924;3923.705722070856;4015.4980627421573;4082.0611259410502;4167.270727622654;4204.642605378577;10177.745556361151;10808.243422960475;10854.891451085388;10905.454727263605;10926.617568385227;10588.629397971034;10721.195910306758;10846.511906964048;10863.83704244437;10874.293170943864;8079.272865442138;8246.216609422216;8252.298554622925;8255.091939886608;8257.545834979133;5471.699056551928;5496.5053145217125;5625.746841392065;5653.915191272216;5770.50950669181;9569.665061722806;9590.472524010967;9662.71011869645;9671.9032809671;9700.466474343697;9491.335606507755;9633.277504187354;9741.756456088655;9860.753481163028;9861.704148875546;6673.9332606673315;6827.965860170667;6995.335443132894;7355.5586664800285;7528.924710753042;7916.168802275678;8307.916920830714;8319.334453243848;8323.583820808813;8329.50022998622;7343.559386436831;7346.742863999734;7432.293932076444;7448.1807001228735;7587.3307872268015;7000.264972177848;7024.051753013277;7034.613096279753;7166.032585600877;7265.164506081868;6893.620850853251;7045.753398631024;7057.929420705727;7059.894101588583;7063.929360706327;5012.899742005213;5072.771725272298;5107.642465027412;5145.173463420432;5328.653637513704;4835.830745923876;5004.324416203766;5044.899102018013;5110.872228194325;5143.254228136974 21:16:32 INFO - PROCESS | 8821 | |4;prototype.html;344.78967829623923;355.05201113028204;356.15235738941317;360.65737549328145;361.4379639660329;5133.897322053556;5142.197502361213;5295.761690723917;5315.76079076442;5333.280007199027;5052.974735126329;5151.974240128803;5221.503957124077;5223.347081614798;5233.502817232356;4179.477565304337;4182;4183.351580505011;4198.895027624303;4211.431456753345;3902.512185976753;3999.4800675912093;4187.078842654626;4199.538050814408;4199.60103790141;4135.31767258402;4137.855175068873;4146.553533415285;4158.625723684868;4168.854090106847;4150.294449943502;4160.209560183571;4163.646090082347;4169.353750168729;4188.602082802129;3475.9652403475893;3721.5906250312446;3755.830987605564;3757.7369584129124;3758.3047136279874;5065.848024559269;5074.22402159245;5089.821856235051;5100.668456550349;5100.719460429675;4641.350210970467;4676.3453116563705;4695.577398034194;4699.2481203007355;4703.741294228816;5211.947880521222;5440.945590544123;5441.1838224266285;5458.208559758852;5477.20580515823;4014.2939250818285;4023.476947996771;4028.3353246714255;4028.4561584186054;4038.515378154611;5635.239242702224;5638.971805140989;5653.8586535336535;5667.910988511271;5675.631083979528;4095.9180816383505;4117.155983023473;4122.2579935611275;4123.659810561579;4130.793460326971;4034.293998550242;4104.179164167179;4145.730527515701;4161.91676166475;4182.498100227992;4695.929561056587;4705.294205869147;4713.128071306819;4735.526447355237;4761.2382018876815;5474.91787623186;5491.697956612345;5492.505674489315;5497.175423686399;5560.4161563036105;1335.723890631988;1384.9197625851853;1392.269058744147;1397.7769451729737;1400;943.7263193673895;964.7925695975399;969.5055521683992;974.025974025974;978.6396908297472;5125.589952803767;5133.4096578893905;5160.8967820643375;5168.508991645787;5173.922391164136;5377.623566350396;5396.8713933840645;5417.31622496706;5422.8915421691345;5462.617616766788;5090.236464530276;5100.38795344561;5101.617378696613;5129.9483605860705;5379.628194810299;2879.726425989528;2890.36411989362;2903.8257704537796;2906.6076079729387;2909.810862293944;5667.943320566824;5681.755706495994;5688.971555142198;5705.942940570624;5711.514521265739;5465.376619222716;5487.890242195133;5534.833954981276;5572.60991730575;5587.972060139755;5633.802816901389;5635.380108188096;5642.802501912495;5643.7742490299925;5658.236138121466;5293.391260005149;5460.26286451324;5465.496988328242;5476.042936814235;5481.068218402801;5569.08110161835;5602.327720673546;5610.49505544503;5618.887622247614;5630.634008789416;5885.323187833454;5887.61730487517;5892.882142357214;5922.3485416605;5937.228160339128;3996.960030399659;4064.7154699170774;4122.381642753611;4168.103857670494;4176.979115104405;5598.272224610774;5621.747021383966;5625.437456254342;5626.606137570331;5635.774569017193;5502.58730595199;5511.4213007633625;5511.476409741068;5521.309836270466;5522.475364840334;5358.33020872391;5376.445998593328;5401.594880383908;5429.40276569585;5463.972680136574;5368.355797304349;5400.351957765093;5426.186072089218;5435.619506634498;5447.536959358499;5342.519173274424;5502.367227768857;5525.9723701382845;5527.309086364205;5541.778328866962;5246.685198888079;5247.737613119252;5264.0259902536545;5265.631405801557;5272.103742363731 21:16:32 INFO - PROCESS | 8821 | |5;yui.html;710.7796583059248;745.8993035940147;807.6365635464043;844.2528362399275;867.3798234262501;13799.172049677014;14345.211013394246;14540.345684444199;14869.776953345681;15439.614009649764;13728.519501817438;13989.370478328474;14270.500532481365;14285.92857035716;14301.642458938531;721.27872127872;852.5353682243192;855.2772906893665;859.0679113162226;860.6170254236868;831.1356189562847;834.8831163637095;835.1398059998181;835.3818174550819;835.4152093534519;891.3983061433539;892.3664198419131;894.5616647842543;894.7494701483595;895.0601868038533;889.4396530185974;891.5675897189858;892.4065496444856;893.6872094766812;893.7944272817289;652.6899722631712;652.9379708927644;655.9540832141752;656.1404560026381;656.6749459017769;12858.485660573566;12881.162724422882;12899.355032248444;12941;13795.862041379558;11533.135014873835;11636.534538618445;11642.742428687172;11701.239419437708;11721.824172637418;11240;11316.773664526663;11433.485493152828;11448.084153267802;11481.598144065001;3807.143392736612;3835.5780864105204;3946.2304850554156;3953.940690889639;3971.0270983609203;39212;46204.306935395995;47192.76403617994;48068.519314806756;64744.3525564743;11364.602238921598;11726.179167458196;11871.70320741971;11885.702857428461;12090.576829810914;17298;18004.729929051075;21132.366029019155;21136.260230891847;21141.894290528755;8837.204651581389;8907.465552066897;9154;9341.870160809925;9393.389429687186;4862.927056094161;5032.798688052437;5080.77136528857;5115.8721031973755;5150.072986862401;3395.7622966392114;3514.279572687644;3514.61339252682;3515.20907795749;3518.683318501347;607.0954278125649;618.3630860213987;619.6313193649771;624.9250089989231;631.5137344244997;714.7927101140715;735.4741359927677;738.2138023005482;779.2129948751801;795.5067857928121;8538.818938112243;8730.345224108218;8792.560371981375;9236.399634023766;9495.287853411022;762.2567996203657;773.1495355109334;780.4653812138703;786.3787607789782;793.9364850811921;4405.229084910128;4521.412216411845;4524.2082635538645;4526.705764125321;4528.139653465897;71673.64163179255;74216;75031;92504.53747731353;95084.52457737805;52190.73904630529;54146.7292663542;71679.28320716726;71808.64095679489;75522.62238688771;63518;64256.67871660612;65144;68120.31879681238;68608.6569567149;8983.191512763882;9250.21373183287;9418.858717119385;9454.385464944757;9546.236301095756;44263.778681106385;44493.77753111214;44869.10261794811;45378.319325209486;45714.085718286115;57205.427945721676;57806.32905064274;58471;62615;63220.683896582064;12579.559715409916;13187.340632968122;13270.867291326964;13347.466101355836;13556.254406007763;13499.325033748077;13740.244286563935;14335.359695847756;14600.196989165273;15081.321340539482;12685.746285074063;13094.738105238033;13320.067595268238;13346.599602011955;14015.649608759863;13460.192388456724;13802.65493362674;13817.930910345383;13992.720145596828;14321.64195895111;12379.257244564995;12823.61529154127;12959.611211663665;12975;13165.60503184906;9865.161461275871;10527.315724477885;10566.8414973777;10598.947005264925;10610.098141658045;10612.575496980344;10624.787504249716;10686;10849.620263291063;10878.94560527224 21:16:32 INFO - PROCESS | 8821 | __end_tp_report 21:16:32 INFO - PROCESS | 8821 | __start_cc_report 21:16:32 INFO - PROCESS | 8821 | _x_x_mozilla_cycle_collect,1029 21:16:32 INFO - PROCESS | 8821 | __end_cc_report 21:16:32 INFO - PROCESS | 8821 | __startTimestamp1483161392206__endTimestamp 21:16:32 INFO - PROCESS | 8821 | 21:16:32 INFO - PROCESS | 8821 | ------- Summary: start ------- 21:16:32 INFO - PROCESS | 8821 | Number of tests: 6 21:16:32 INFO - PROCESS | 8821 | 21:16:32 INFO - PROCESS | 8821 | [#0] dojo.html Cycles:165 Average:5475.51 Median:5677.89 stddev:607.28 (10.7%) stddev-sans-first:581.71 21:16:32 INFO - PROCESS | 8821 | Values: 3175.3 3179.7 3201.6 3216.1 3243.9 5413.6 5495.4 5499.5 5508.8 5514.4 5515.2 5546.7 5550.4 5569.9 5589.3 5025.7 5045.3 5070.9 5076.3 5137.0 4895.7 5077.3 5124.9 5129.5 5134.2 4891.7 4946.6 5023.9 5051.4 5051.9 5002.7 5029.1 5043.8 5109.3 5139.3 4943.1 5011.1 5059.8 5077.8 5083.8 5300.6 5369.9 5380.3 5460.4 5501.3 5781.5 5790.7 5799.1 5897.8 5908.0 5944.9 5959.9 5960.1 5966.9 5968.6 5395.6 5426.3 5479.6 5521.5 5523.8 6035.5 6066.0 6070.3 6072.1 6079.3 5837.9 5840.7 5841.5 5847.8 5855.4 5658.0 5704.5 5773.5 5813.6 5820.4 5859.7 5861.7 5862.9 5884.5 5896.2 5809.5 5860.1 5869.6 5872.7 5874.0 4438.3 4477.6 4546.1 4567.2 4598.7 4081.4 4118.5 4135.0 4138.9 4162.4 5654.5 5670.4 5677.9 5681.5 5683.5 5728.6 5734.0 5804.9 5989.1 5993.9 5440.0 5510.2 5516.1 5528.9 5539.7 5069.3 5070.0 5071.7 5072.8 5089.1 5881.0 6010.1 6020.9 6022.9 6023.7 5815.2 5826.0 5845.0 5916.7 5943.7 6143.2 6145.5 6145.8 6146.7 6150.5 5658.0 5809.8 5824.7 5825.9 5828.0 5815.4 5903.4 5939.1 5952.7 6022.5 5848.5 5851.8 5852.2 5854.3 5856.6 5737.2 5872.4 5874.1 5876.1 5880.4 5504.9 5549.1 5660.3 5682.5 5692.0 5845.9 5850.5 5852.3 5858.7 5869.1 5346.6 5406.5 5568.6 5571.9 5582.9 21:16:32 INFO - PROCESS | 8821 | 21:16:32 INFO - PROCESS | 8821 | [#1] ext.html Cycles:180 Average:63110.35 Median:39962.10 stddev:128996.92 (322.8%) stddev-sans-first:129273.37 21:16:32 INFO - PROCESS | 8821 | Values: 587.5 620.7 622.8 653.2 659.8 33490.7 36745.4 44596.8 45158.0 45204.3 46751.8 47182.3 47191.0 47215.5 47227.3 8205.3 8780.2 8926.9 8928.3 8928.6 8167.9 10577.9 10822.9 10828.4 11123.7 10799.5 10852.6 10858.6 10863.5 10867.7 10673.5 10700.4 10741.9 10766.5 10773.1 10571.0 10626.7 10627.6 10627.9 10632.4 43243.6 43355.0 43574.6 43582.8 43644.3 3610.3 3693.4 3918.8 4050.0 4324.3 32242.5 32924.7 33146.5 33177.7 33385.8 3920.6 4089.5 4124.6 4199.4 4218.2 340929.0 343876.0 346906.0 347626.0 347920.0 60750.7 60798.4 60855.7 60892.7 60902.4 39387.4 40186.6 40189.2 42469.8 42675.0 14959.8 15180.0 15193.8 15206.8 15212.0 10265.4 10345.0 11047.1 11144.7 11218.9 19686.5 20342.5 20400.0 20620.5 20622.7 7316.4 7336.6 7369.3 7396.9 7664.5 965.7 1019.2 1035.0 1059.5 1110.8 33649.8 34414.5 34715.7 34827.7 34911.7 1040.0 1081.7 1114.1 1116.9 1188.9 16024.7 18227.4 18364.0 18684.2 19080.3 588440.0 588587.0 589286.0 590464.0 593152.0 63640.0 63993.0 64010.0 64011.0 64065.0 1308.2 1327.8 1371.9 1388.5 1429.4 32637.0 35295.0 35317.3 35716.1 35730.1 52277.0 52675.7 52768.5 52866.5 52918.7 341759.0 342468.0 342636.0 344070.0 838688.0 45365.3 45620.1 47343.8 47498.0 48340.5 51937.2 52750.5 52780.0 52793.7 53175.5 44307.6 44660.0 45094.0 45113.0 45808.5 45715.3 45850.9 45997.5 46072.3 46171.4 45435.0 45498.0 45583.5 45952.8 46359.5 37645.8 39737.6 40669.0 40825.4 41105.2 30252.4 30642.8 30673.4 30786.2 30872.0 21:16:32 INFO - PROCESS | 8821 | 21:16:32 INFO - PROCESS | 8821 | [#2] jquery.html Cycles:180 Average:30152.77 Median:13026.88 stddev:85920.56 (659.6%) stddev-sans-first:86132.52 21:16:32 INFO - PROCESS | 8821 | Values: 390.5 430.2 438.3 442.5 448.9 16463.6 19149.8 20088.2 20109.6 20289.8 19557.5 20102.2 20145.0 20225.6 20388.3 5712.7 5917.4 5923.9 5929.6 5932.1 5588.6 5829.5 5855.9 5858.9 5859.1 5622.0 5846.0 5849.4 5850.7 5852.6 5726.5 5823.6 5825.2 5826.1 5827.7 5090.0 5233.6 5245.7 5246.0 5246.1 23133.1 23495.9 23501.0 23663.9 23900.6 2352.6 2389.9 2390.4 2518.7 3008.7 14744.7 14901.6 15190.2 15269.6 15316.7 1949.6 1974.5 1988.4 2005.8 2035.9 84104.6 85451.6 85904.6 87531.0 88324.0 9841.8 10754.1 10986.5 11022.6 11280.1 14304.0 14458.0 15482.3 15502.9 16204.1 7446.8 7618.6 7628.8 7631.6 7644.0 7040.1 7086.1 7090.1 7120.9 7265.4 6805.8 6832.7 6891.3 6899.4 6915.3 1996.5 2029.5 2038.3 2068.9 2082.6 994.4 1019.0 1045.2 1049.3 1105.7 19168.9 19606.6 19684.8 20294.8 20606.3 1009.7 1044.7 1051.5 1090.8 1100.8 11091.7 11488.0 11549.6 11688.0 11704.3 495696.0 500581.0 530799.1 539070.0 544305.0 83653.0 88046.1 88998.6 89030.0 89812.6 1024.7 1052.6 1053.7 1054.6 1063.4 17314.7 17726.4 18067.7 18186.5 18270.8 42297.4 42426.6 42470.0 42699.6 42736.8 53578.0 55038.4 55497.0 56384.0 56747.7 8848.8 8858.0 8987.5 9015.5 9021.4 9728.6 13228.9 13382.1 13403.7 13707.9 12002.7 12070.2 12150.6 12380.6 12521.4 11365.1 11633.4 11648.0 11877.4 11998.8 6614.9 12063.2 12066.5 12243.5 12951.6 8925.3 8996.0 9000.8 9120.1 9335.1 11674.9 11740.8 12147.5 12233.3 12273.3 21:16:32 INFO - PROCESS | 8821 | 21:16:32 INFO - PROCESS | 8821 | [#3] mootools.html Cycles:180 Average:5624.50 Median:5136.20 stddev:3167.55 (61.7%) stddev-sans-first:3159.93 21:16:32 INFO - PROCESS | 8821 | Values: 1321.9 1351.4 1416.8 1456.9 1824.1 7633.0 8326.6 8545.1 8600.6 8899.3 8673.5 8681.3 8732.9 8738.5 8744.7 2331.1 2359.7 2360.3 2361.1 2363.8 2188.2 2218.3 2325.1 2329.2 2331.3 2122.7 2125.5 2133.4 2146.2 2168.6 2233.8 2248.1 2249.1 2265.3 2267.3 2107.8 2118.2 2125.6 2129.0 2131.6 8618.1 8734.9 8745.0 8758.0 8816.8 5129.2 5305.1 5310.0 5380.9 5404.6 3233.9 3248.4 3259.1 3299.4 3312.5 944.9 949.7 959.7 973.1 1030.6 10844.8 11168.8 11214.6 11844.1 12033.1 4509.8 4619.2 4741.3 4765.8 4768.7 9544.7 9550.3 9557.6 9559.1 9559.9 5233.9 5269.7 5271.9 5273.3 5285.2 4381.8 4515.6 4868.5 4928.3 5033.9 3929.2 4025.6 4063.8 4109.2 4118.7 1266.2 1341.2 1357.8 1363.3 1368.8 965.3 984.8 1002.5 1011.1 1023.8 5699.8 5860.4 5923.3 6014.3 6094.7 458.6 460.7 462.2 983.0 1069.7 3923.7 4015.5 4082.1 4167.3 4204.6 10177.7 10808.2 10854.9 10905.5 10926.6 10588.6 10721.2 10846.5 10863.8 10874.3 8079.3 8246.2 8252.3 8255.1 8257.5 5471.7 5496.5 5625.7 5653.9 5770.5 9569.7 9590.5 9662.7 9671.9 9700.5 9491.3 9633.3 9741.8 9860.8 9861.7 6673.9 6828.0 6995.3 7355.6 7528.9 7916.2 8307.9 8319.3 8323.6 8329.5 7343.6 7346.7 7432.3 7448.2 7587.3 7000.3 7024.1 7034.6 7166.0 7265.2 6893.6 7045.8 7057.9 7059.9 7063.9 5012.9 5072.8 5107.6 5145.2 5328.7 4835.8 5004.3 5044.9 5110.9 5143.3 21:16:32 INFO - PROCESS | 8821 | 21:16:32 INFO - PROCESS | 8821 | [#4] prototype.html Cycles:180 Average:4610.99 Median:5228.42 stddev:1327.18 (25.4%) stddev-sans-first:1291.70 21:16:32 INFO - PROCESS | 8821 | Values: 344.8 355.1 356.2 360.7 361.4 5133.9 5142.2 5295.8 5315.8 5333.3 5053.0 5152.0 5221.5 5223.3 5233.5 4179.5 4182.0 4183.4 4198.9 4211.4 3902.5 3999.5 4187.1 4199.5 4199.6 4135.3 4137.9 4146.6 4158.6 4168.9 4150.3 4160.2 4163.6 4169.4 4188.6 3476.0 3721.6 3755.8 3757.7 3758.3 5065.8 5074.2 5089.8 5100.7 5100.7 4641.4 4676.3 4695.6 4699.2 4703.7 5211.9 5440.9 5441.2 5458.2 5477.2 4014.3 4023.5 4028.3 4028.5 4038.5 5635.2 5639.0 5653.9 5667.9 5675.6 4095.9 4117.2 4122.3 4123.7 4130.8 4034.3 4104.2 4145.7 4161.9 4182.5 4695.9 4705.3 4713.1 4735.5 4761.2 5474.9 5491.7 5492.5 5497.2 5560.4 1335.7 1384.9 1392.3 1397.8 1400.0 943.7 964.8 969.5 974.0 978.6 5125.6 5133.4 5160.9 5168.5 5173.9 5377.6 5396.9 5417.3 5422.9 5462.6 5090.2 5100.4 5101.6 5129.9 5379.6 2879.7 2890.4 2903.8 2906.6 2909.8 5667.9 5681.8 5689.0 5705.9 5711.5 5465.4 5487.9 5534.8 5572.6 5588.0 5633.8 5635.4 5642.8 5643.8 5658.2 5293.4 5460.3 5465.5 5476.0 5481.1 5569.1 5602.3 5610.5 5618.9 5630.6 5885.3 5887.6 5892.9 5922.3 5937.2 3997.0 4064.7 4122.4 4168.1 4177.0 5598.3 5621.7 5625.4 5626.6 5635.8 5502.6 5511.4 5511.5 5521.3 5522.5 5358.3 5376.4 5401.6 5429.4 5464.0 5368.4 5400.4 5426.2 5435.6 5447.5 5342.5 5502.4 5526.0 5527.3 5541.8 5246.7 5247.7 5264.0 5265.6 5272.1 21:16:32 INFO - PROCESS | 8821 | 21:16:32 INFO - PROCESS | 8821 | [#5] yui.html Cycles:180 Average:16749.77 Median:46698.54 stddev:21334.06 (45.7%) stddev-sans-first:21359.91 21:16:32 INFO - PROCESS | 8821 | Values: 710.8 745.9 807.6 844.3 867.4 13799.2 14345.2 14540.3 14869.8 15439.6 13728.5 13989.4 14270.5 14285.9 14301.6 721.3 852.5 855.3 859.1 860.6 831.1 834.9 835.1 835.4 835.4 891.4 892.4 894.6 894.7 895.1 889.4 891.6 892.4 893.7 893.8 652.7 652.9 656.0 656.1 656.7 12858.5 12881.2 12899.4 12941.0 13795.9 11533.1 11636.5 11642.7 11701.2 11721.8 11240.0 11316.8 11433.5 11448.1 11481.6 3807.1 3835.6 3946.2 3953.9 3971.0 39212.0 46204.3 47192.8 48068.5 64744.4 11364.6 11726.2 11871.7 11885.7 12090.6 17298.0 18004.7 21132.4 21136.3 21141.9 8837.2 8907.5 9154.0 9341.9 9393.4 4862.9 5032.8 5080.8 5115.9 5150.1 3395.8 3514.3 3514.6 3515.2 3518.7 607.1 618.4 619.6 624.9 631.5 714.8 735.5 738.2 779.2 795.5 8538.8 8730.3 8792.6 9236.4 9495.3 762.3 773.1 780.5 786.4 793.9 4405.2 4521.4 4524.2 4526.7 4528.1 71673.6 74216.0 75031.0 92504.5 95084.5 52190.7 54146.7 71679.3 71808.6 75522.6 63518.0 64256.7 65144.0 68120.3 68608.7 8983.2 9250.2 9418.9 9454.4 9546.2 44263.8 44493.8 44869.1 45378.3 45714.1 57205.4 57806.3 58471.0 62615.0 63220.7 12579.6 13187.3 13270.9 13347.5 13556.3 13499.3 13740.2 14335.4 14600.2 15081.3 12685.7 13094.7 13320.1 13346.6 14015.6 13460.2 13802.7 13817.9 13992.7 14321.6 12379.3 12823.6 12959.6 12975.0 13165.6 9865.2 10527.3 10566.8 10598.9 10610.1 10612.6 10624.8 10686.0 10849.6 10878.9 21:16:32 INFO - PROCESS | 8821 | -------- Summary: end -------- 21:16:32 INFO - PROCESS | 8821 | 21:16:32 INFO - TEST-INFO | 8821: exit 0 21:16:33 INFO - TEST-OK | dromaeo_css | took 1115434ms 21:16:33 INFO - TEST-START | kraken 21:16:33 INFO - operating with platform_type : linux_ 21:16:33 INFO - Initialising browser for kraken test... 21:16:33 INFO - TEST-INFO | started process 9138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcLv38J/profile http://localhost:40130/getInfo.html) 21:16:36 INFO - PROCESS | 9138 | __metrics Screen width/height:1600/1200 21:16:36 INFO - PROCESS | 9138 | colorDepth:24 21:16:36 INFO - PROCESS | 9138 | Browser inner width/height: 1024/697 21:16:36 INFO - PROCESS | 9138 | __metrics 21:16:37 INFO - PROCESS | 9138 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:16:37 INFO - PROCESS | 9138 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:16:37 INFO - PROCESS | 9138 | console.error: PushService: 21:16:37 INFO - PROCESS | 9138 | stateChangeProcessEnqueue: Error transitioning state 21:16:37 INFO - PROCESS | 9138 | UnknownError 21:16:38 INFO - TEST-INFO | 9138: exit 0 21:16:38 INFO - Browser initialized. 21:16:38 INFO - Running cycle 1/1 for kraken test... 21:16:38 INFO - TEST-INFO | started process 9229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcLv38J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:50 INFO - PROCESS | 9229 | RSS: Main: 144920576 21:16:50 INFO - PROCESS | 9229 | 21:16:52 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-beat-detection) 21:16:53 INFO - PROCESS | 9229 | RSS: Main: 185978880 21:16:53 INFO - PROCESS | 9229 | 21:16:56 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-dft) 21:16:56 INFO - PROCESS | 9229 | RSS: Main: 174743552 21:16:56 INFO - PROCESS | 9229 | 21:16:59 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-fft) 21:17:00 INFO - PROCESS | 9229 | RSS: Main: 266342400 21:17:00 INFO - PROCESS | 9229 | 21:17:02 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-oscillator) 21:17:03 INFO - PROCESS | 9229 | RSS: Main: 173576192 21:17:03 INFO - PROCESS | 9229 | 21:17:05 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40130/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:17:05 INFO - PROCESS | 9229 | RSS: Main: 175620096 21:17:05 INFO - PROCESS | 9229 | 21:17:08 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40130/tests/kraken/driver.html?testName=imaging-darkroom) 21:17:09 INFO - PROCESS | 9229 | RSS: Main: 213946368 21:17:09 INFO - PROCESS | 9229 | 21:17:12 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40130/tests/kraken/driver.html?testName=imaging-desaturate) 21:17:13 INFO - PROCESS | 9229 | RSS: Main: 212631552 21:17:13 INFO - PROCESS | 9229 | 21:17:15 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40130/tests/kraken/driver.html?testName=json-parse-financial) 21:17:16 INFO - PROCESS | 9229 | RSS: Main: 211664896 21:17:16 INFO - PROCESS | 9229 | 21:17:17 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40130/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:17:18 INFO - PROCESS | 9229 | RSS: Main: 173776896 21:17:18 INFO - PROCESS | 9229 | 21:17:20 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:17:20 INFO - PROCESS | 9229 | RSS: Main: 180908032 21:17:20 INFO - PROCESS | 9229 | 21:17:22 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:17:23 INFO - PROCESS | 9229 | RSS: Main: 190107648 21:17:23 INFO - PROCESS | 9229 | 21:17:25 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:17:26 INFO - PROCESS | 9229 | RSS: Main: 198885376 21:17:26 INFO - PROCESS | 9229 | 21:17:29 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:17:29 INFO - PROCESS | 9229 | RSS: Main: 195477504 21:17:29 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40130/tests/kraken/driver.html?testName=ai-astar) 21:17:31 INFO - PROCESS | 9229 | RSS: Main: 246968320 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | __start_tp_report 21:17:31 INFO - PROCESS | 9229 | _x_x_mozilla_page_load 21:17:31 INFO - PROCESS | 9229 | _x_x_mozilla_page_load_details 21:17:31 INFO - PROCESS | 9229 | |i|pagename|runs| 21:17:31 INFO - PROCESS | 9229 | |0;ai-astar;102;114;112;112;113;114;110;113;112;112 21:17:31 INFO - PROCESS | 9229 | |1;audio-beat-detection;142;118;119;165;121;119;119;120;158;116 21:17:31 INFO - PROCESS | 9229 | |2;audio-dft;162;162;162;161;162;161;163;161;160;160 21:17:31 INFO - PROCESS | 9229 | |3;audio-fft;76;75;75;107;87;77;76;77;97;76 21:17:31 INFO - PROCESS | 9229 | |4;audio-oscillator;83;83;120;83;84;83;108;81;82;118 21:17:31 INFO - PROCESS | 9229 | |5;imaging-gaussian-blur;117;118;117;116;116;117;117;117;117;117 21:17:31 INFO - PROCESS | 9229 | |6;imaging-darkroom;147;147;145;147;148;147;146;147;146;146 21:17:31 INFO - PROCESS | 9229 | |7;imaging-desaturate;85;85;86;84;85;85;84;85;84;85 21:17:31 INFO - PROCESS | 9229 | |8;json-parse-financial;50;50;50;51;49;50;51;50;50;49 21:17:31 INFO - PROCESS | 9229 | |9;json-stringify-tinderbox;58;57;59;58;58;58;57;58;58;58 21:17:31 INFO - PROCESS | 9229 | |10;stanford-crypto-aes;74;76;76;75;81;82;78;75;82;74 21:17:31 INFO - PROCESS | 9229 | |11;stanford-crypto-ccm;127;128;130;120;121;134;136;128;171;129 21:17:31 INFO - PROCESS | 9229 | |12;stanford-crypto-pbkdf2;157;156;155;154;151;156;156;155;153;153 21:17:31 INFO - PROCESS | 9229 | |13;stanford-crypto-sha256-iterative;63;62;61;62;62;62;63;61;61;63 21:17:31 INFO - PROCESS | 9229 | __end_tp_report 21:17:31 INFO - PROCESS | 9229 | __start_cc_report 21:17:31 INFO - PROCESS | 9229 | _x_x_mozilla_cycle_collect,1610 21:17:31 INFO - PROCESS | 9229 | __end_cc_report 21:17:31 INFO - PROCESS | 9229 | __startTimestamp1483161451829__endTimestamp 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | ------- Summary: start ------- 21:17:31 INFO - PROCESS | 9229 | Number of tests: 14 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.50 (3.1%) stddev-sans-first:1.24 21:17:31 INFO - PROCESS | 9229 | Values: 102.0 114.0 112.0 112.0 113.0 114.0 110.0 113.0 112.0 112.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:120.50 stddev:18.37 (15.2%) stddev-sans-first:18.93 21:17:31 INFO - PROCESS | 9229 | Values: 142.0 118.0 119.0 165.0 121.0 119.0 119.0 120.0 158.0 116.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 21:17:31 INFO - PROCESS | 9229 | Values: 162.0 162.0 162.0 161.0 162.0 161.0 163.0 161.0 160.0 160.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.50 stddev:11.21 (14.6%) stddev-sans-first:11.65 21:17:31 INFO - PROCESS | 9229 | Values: 76.0 75.0 75.0 107.0 87.0 77.0 76.0 77.0 97.0 76.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:83.00 stddev:16.06 (19.4%) stddev-sans-first:16.67 21:17:31 INFO - PROCESS | 9229 | Values: 83.0 83.0 120.0 83.0 84.0 83.0 108.0 81.0 82.0 118.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 21:17:31 INFO - PROCESS | 9229 | Values: 117.0 118.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 21:17:31 INFO - PROCESS | 9229 | Values: 147.0 147.0 145.0 147.0 148.0 147.0 146.0 147.0 146.0 146.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 21:17:31 INFO - PROCESS | 9229 | Values: 85.0 85.0 86.0 84.0 85.0 85.0 84.0 85.0 84.0 85.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 21:17:31 INFO - PROCESS | 9229 | Values: 50.0 50.0 50.0 51.0 49.0 50.0 51.0 50.0 50.0 49.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 21:17:31 INFO - PROCESS | 9229 | Values: 58.0 57.0 59.0 58.0 58.0 58.0 57.0 58.0 58.0 58.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.00 stddev:3.23 (4.2%) stddev-sans-first:3.20 21:17:31 INFO - PROCESS | 9229 | Values: 74.0 76.0 76.0 75.0 81.0 82.0 78.0 75.0 82.0 74.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:129.50 stddev:14.43 (11.1%) stddev-sans-first:15.17 21:17:31 INFO - PROCESS | 9229 | Values: 127.0 128.0 130.0 120.0 121.0 134.0 136.0 128.0 171.0 129.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.50 stddev:1.84 (1.2%) stddev-sans-first:1.73 21:17:31 INFO - PROCESS | 9229 | Values: 157.0 156.0 155.0 154.0 151.0 156.0 156.0 155.0 153.0 153.0 21:17:31 INFO - PROCESS | 9229 | 21:17:31 INFO - PROCESS | 9229 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 21:17:31 INFO - PROCESS | 9229 | Values: 63.0 62.0 61.0 62.0 62.0 62.0 63.0 61.0 61.0 63.0 21:17:31 INFO - PROCESS | 9229 | -------- Summary: end -------- 21:17:31 INFO - PROCESS | 9229 | 21:17:32 INFO - TEST-INFO | 9229: exit 0 21:17:32 INFO - TEST-OK | kraken | took 59900ms 21:17:32 INFO - SUITE-END | took 1175s 21:17:32 INFO - Completed test suite (00:19:35) 21:17:32 INFO - javascript benchmark 21:17:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3175.3490534440434, 3179.7297229735464, 3201.647818739938, 3216.1477208539727, 3243.935121297574, 5413.648112872661, 5495.422980587035, 5499.450054994499, 5508.7796488140475, 5514.393416724157, 5515.172724091388, 5546.667199968005, 5550.417206193352, 5569.944300556993, 5589.329280486337, 5025.698458092517, 5045.293658887758, 5070.923936140961, 5076.314697515843, 5137.023965446553, 4895.681780684262, 5077.339945807058, 5124.8975020499565, 5129.53834154926, 5134.204198349262, 4891.730954797485, 4946.579540739023, 5023.924641130386, 5051.444341122474, 5051.924221136685, 5002.699838009713, 5029.1450453423, 5043.823466178666, 5109.284700141983, 5139.254808052811, 4943.085529177078, 5011.1481048221885, 5059.822906198302, 5077.847664570068, 5083.79664813407, 5300.602454815866, 5369.892602147975, 5380.300560927094, 5460.372057213432, 5501.257330260443, 5781.479666830005, 5790.7394167262155, 5799.130130480462, 5897.8230653080045, 5908.0, 5944.881102377928, 5959.880802383971, 5960.105984102376, 5966.940330596725, 5968.612040217372, 5395.649282796606, 5426.321709786316, 5479.6164268500825, 5521.475459831309, 5523.806666766724, 6035.456808887221, 6065.96967015171, 6070.3019152798, 6072.05883088122, 6079.300880398722, 5837.854053648693, 5840.707964601753, 5841.50347220491, 5847.766089356463, 5855.443732845373, 5657.971710141505, 5704.543636509069, 5773.509251713567, 5813.6221145625395, 5820.447057529528, 5859.707014649251, 5861.706914654335, 5862.882742345129, 5884.499817515473, 5896.204012458264, 5809.506191973645, 5860.062390017662, 5869.647821130746, 5872.706364681749, 5874.0, 4438.334249862546, 4477.6417886569, 4546.090781843578, 4567.1550763108935, 4598.655100867449, 4081.4490043844294, 4118.5263694674895, 4135.048938744106, 4138.91722165555, 4162.354835000579, 5654.547636189095, 5670.404607516234, 5677.886442271131, 5681.460261275172, 5683.460071293221, 5728.598998070095, 5733.9965506037115, 5804.88390232193, 5989.101634754735, 5993.880122397615, 5439.972800135974, 5510.173473978855, 5516.089845175501, 5528.944710552923, 5539.695316757617, 5069.340985671839, 5070.036693028313, 5071.670341427795, 5072.847814565569, 5089.083964886356, 5880.970595146997, 6010.098485227163, 6020.909686354796, 6022.909656355158, 6023.668698221552, 5815.244018277597, 5825.970870145622, 5845.035569131046, 5916.704164791657, 5943.673097979479, 6143.201383820075, 6145.539084568764, 6145.84635384119, 6146.661933593696, 6150.538709596887, 5658.0, 5809.767609295581, 5824.70876456167, 5825.94174058254, 5827.9708601458415, 5815.360310365941, 5903.350631430625, 5939.138824870456, 5952.702364881825, 6022.548308876764, 5848.53211743051, 5851.824445266649, 5852.239208902815, 5854.326752423526, 5856.648601083949, 5737.225474560881, 5872.354041055566, 5874.060150375919, 5876.118582212703, 5880.353161152184, 5504.889902201853, 5549.139883318092, 5660.264165658438, 5682.545396368363, 5692.0, 5845.912311315419, 5850.5027072699295, 5852.297724273115, 5858.677772722541, 5869.148973398918, 5346.625736198429, 5406.486383793534, 5568.55451563882, 5571.860703482445, 5582.916256256078], "value": 5435.560653228356, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.4976894754984, 620.6865532905882, 622.7571247213587, 653.2030922274826, 659.7690808217121, 33490.66509334909, 36745.448818267745, 44596.77701611495, 45158.0, 45204.32193517092, 46751.76624116875, 47182.292265616044, 47191.0, 47215.527844721626, 47227.29159062608, 8205.343572514184, 8780.209781119682, 8926.910730892672, 8928.285737141014, 8928.55357232139, 8167.877481837748, 10577.894221057806, 10822.945885270563, 10828.40443775592, 11123.666290011313, 10799.460026998659, 10852.565897364097, 10858.619948301812, 10863.51114199863, 10867.673969780919, 10673.519691613896, 10700.357978521275, 10741.946290268577, 10766.515506802212, 10773.084287835543, 10571.0, 10626.681199564026, 10627.628033018884, 10627.946860265727, 10632.362058276529, 43243.567564324585, 43355.0, 43574.56425435737, 43582.78208608968, 43644.345334819685, 3610.259896721192, 3693.445983102529, 3918.784466854322, 4050.0, 4324.329728892027, 32242.51636225435, 32924.6707532924, 33146.50280245774, 33177.6682233177, 33385.833070834735, 3920.627540383659, 4089.5297040840387, 4124.566920473367, 4199.391088292181, 4218.156368726267, 340929.0, 343876.0, 346906.0, 347626.0, 347920.0, 60750.696246518484, 60798.39201608016, 60855.695721521995, 60892.695536522035, 60902.39097608967, 39387.40918886219, 40186.598134018874, 40189.1962160761, 42469.787651061546, 42675.0, 14959.77560336574, 15180.0, 15193.848061519464, 15206.771898421532, 15212.0, 10265.435401052864, 10345.0, 11047.060999815105, 11144.721381965353, 11218.943905280421, 19686.507837303896, 20342.49143771388, 20400.0, 20620.48448788762, 20622.690659640117, 7316.378107860785, 7336.596487193149, 7369.299916507923, 7396.9260307396235, 7664.540127592362, 965.666844938495, 1019.169376957777, 1034.9896501035043, 1059.502034043998, 1110.8000559899297, 33649.83175084109, 34414.48378274328, 34715.65284347175, 34827.651723482944, 34911.65088349135, 1039.9584016639249, 1081.7331658391613, 1114.1309778372881, 1116.9497372618252, 1188.869224385317, 16024.679506409806, 18227.362042328456, 18364.0, 18684.159212835453, 19080.332188373617, 588440.0, 588587.0, 589286.0, 590464.0, 593152.0, 63640.0, 63993.0, 64010.0, 64011.0, 64065.0, 1308.2150709574369, 1327.8406591208923, 1371.8559551247174, 1388.5001399496173, 1429.4067961795947, 32637.0, 35295.0, 35317.29365412729, 35716.107097321736, 35730.10674733153, 52277.0, 52675.736621316646, 52768.472315276354, 52866.47133528616, 52918.735406322725, 341759.0, 342468.0, 342636.0, 344070.0, 838688.0, 45365.31952020656, 45620.087598247184, 47343.763281183376, 47498.0, 48340.51659483501, 51937.22094168515, 52750.47249527455, 52780.0, 52793.73603132113, 53175.46824531705, 44307.55692443034, 44660.0, 45094.0, 45113.0, 45808.541914580426, 45715.31427028664, 45850.93670784756, 45997.54002459932, 46072.308915366964, 46171.41717164187, 45435.0, 45498.0, 45583.54416455926, 45952.77023614861, 46359.536404635524, 37645.81177094206, 39737.60262397339, 40669.0, 40825.442826091676, 41105.1778964413, 30252.394952100396, 30642.846785765927, 30673.38653226878, 30786.230344241572, 30872.0], "value": 21216.245237283958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.5072144972096, 430.16547897079664, 438.26590460977854, 442.4690371554135, 448.88104652267134, 16463.588410289733, 19149.755265907705, 20088.196472141117, 20109.59780804383, 20289.797102028977, 19557.511062223453, 20102.195912163497, 20145.0, 20225.595488090228, 20388.286409975655, 5712.685802280873, 5917.40825917407, 5923.88152236955, 5929.644221346733, 5932.080527518242, 5588.636738611997, 5829.533637309027, 5855.941440585603, 5858.912116318259, 5859.0625499920025, 5622.0, 5845.970770146165, 5849.356570777211, 5850.6782126983, 5852.648841069528, 5726.484616384525, 5823.56323275756, 5825.1844741736195, 5826.067829147316, 5827.708614569276, 5089.9745501272255, 5233.581313494949, 5245.711485868275, 5246.0, 5246.134387826004, 23133.074677013068, 23495.88252058746, 23501.0, 23663.881680591658, 23900.641490377657, 2352.6471029345735, 2389.880505974694, 2390.378501589582, 2518.748125187485, 3008.74425673818, 14744.705105897821, 14901.552953411307, 15190.164540950243, 15269.61825954349, 15316.693666126615, 1949.6393167264102, 1974.5261137327082, 1988.363723608446, 2005.7693365263035, 2035.9209618902005, 84104.57947710222, 85451.57274213652, 85904.57047714783, 87531.0, 88324.0, 9841.753956151153, 10754.139668826476, 10986.450677466095, 11022.559097636165, 11280.097592192606, 14304.0, 14458.0, 15482.30329635169, 15502.922485387726, 16204.108774017306, 7446.7712827382875, 7618.5809780462605, 7628.847423051508, 7631.580263085472, 7643.961780191064, 7040.119985001875, 7086.114235720535, 7090.078289822393, 7120.9349288706735, 7265.4187664986675, 6805.795826125224, 6832.726690932307, 6891.345322194384, 6899.448044156456, 6915.343042410963, 1996.5208349996187, 2029.4723371923405, 2038.2560365466795, 2068.8758674479277, 2082.5938941906484, 994.4232345239743, 1018.9519066676035, 1045.2160879340495, 1049.3074570783247, 1105.6517197082894, 19168.904155479133, 19606.607867842562, 19684.803151968583, 20294.797052029586, 20606.27878024262, 1009.6869970309081, 1044.681372181492, 1051.5320682296458, 1090.8363745438248, 1100.818364969771, 11091.667249982513, 11488.0, 11549.595764148382, 11688.0, 11704.297742135499, 495696.0, 500581.0, 530799.1140398692, 539070.0, 544305.0, 83653.0, 88046.11953880379, 88998.55500722455, 89030.0, 89812.5509372449, 1024.7130803375067, 1052.6052730226165, 1053.657561292583, 1054.6361505280665, 1063.4363787192801, 17314.65370692604, 17726.379576714753, 18067.728984064986, 18186.45440636783, 18270.817291827443, 42297.365539517545, 42426.575734242266, 42470.0, 42699.57300426956, 42736.78631606822, 53578.041769881966, 55038.449615503334, 55497.0, 56384.0, 56747.71626141843, 8848.778780530538, 8858.0, 8987.505687187268, 9015.549222538715, 9021.413608115452, 9728.610855565697, 13228.933855330662, 13382.063255572017, 13403.731925361242, 13707.931460343034, 12002.699932501757, 12070.215435996632, 12150.635480935585, 12380.566680166152, 12521.436535355748, 11365.147613928822, 11633.360165190996, 11648.0, 11877.406129693654, 11998.820017699916, 6614.90077648826, 12063.155579109729, 12066.457009434773, 12243.510259589517, 12951.611451656465, 8925.285977121945, 8995.95502022512, 9000.774980625274, 9120.133587309196, 9335.113164249386, 11674.883251167379, 11740.765184696087, 12147.453364598437, 12233.3271670059, 12273.263604183778], "value": 9556.58579112622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.9074664773464, 1351.4391527516082, 1416.7945647881058, 1456.9271536423175, 1824.051493223523, 7632.961835190823, 8326.625301861422, 8545.102764209754, 8600.56997150143, 8899.332550058756, 8673.479591224532, 8681.26209272211, 8732.8690069649, 8738.475691458518, 8744.737657870273, 2331.079223706635, 2359.740428552858, 2360.303710405426, 2361.055577768889, 2363.8463499872455, 2188.2122435923056, 2218.256883943881, 2325.1164557468137, 2329.184785325131, 2331.265651319837, 2122.7028216049766, 2125.5005073807642, 2133.445304220906, 2146.2380854796556, 2168.642174041281, 2233.8101261392803, 2248.067052173346, 2249.0778780699916, 2265.3430505153488, 2267.297137887252, 2107.7681455039933, 2118.1739121742535, 2125.5961367340155, 2128.968065479019, 2131.5736852629534, 8618.138186181332, 8734.912650873473, 8745.0, 8758.036615972238, 8816.779580510474, 5129.153689641204, 5305.098133317345, 5310.0, 5380.946190538084, 5404.5946554008215, 3233.87064517419, 3248.3665685191395, 3259.08745551246, 3299.373119107362, 3312.453445181542, 944.8629948657475, 949.6581230756922, 959.6785076999214, 973.109604711688, 1030.598066753959, 10844.783104337868, 11168.776624467546, 11214.607488737855, 11844.052475801915, 12033.097517686208, 4509.751963641966, 4619.23782575878, 4741.336212930192, 4765.785539650724, 4768.713877167381, 9544.665936692183, 9550.331476796697, 9557.569909354095, 9559.091886270931, 9559.90440095604, 5233.947660523422, 5269.657472264291, 5271.947280527223, 5273.2617433559335, 5285.207218917117, 4381.824727010884, 4515.593596576324, 4868.464468908417, 4928.260760885896, 5033.874153146127, 3929.214157168578, 4025.5571887092397, 4063.756174629532, 4109.239790638741, 4118.670506359484, 1266.183311763907, 1341.215388997428, 1357.7827547592337, 1363.3251540487522, 1368.8015237790464, 965.3238954944879, 984.8128855517429, 1002.4937406609615, 1011.079917275276, 1023.7542989682422, 5699.772009119672, 5860.384659610765, 5923.289205295306, 6014.278286605635, 6094.6647934363145, 458.5712358944398, 460.6591122569275, 462.19577934393914, 982.9557669904872, 1069.6737495063924, 3923.705722070856, 4015.4980627421573, 4082.0611259410502, 4167.270727622654, 4204.642605378577, 10177.745556361151, 10808.243422960475, 10854.891451085388, 10905.454727263605, 10926.617568385227, 10588.629397971034, 10721.195910306758, 10846.511906964048, 10863.83704244437, 10874.293170943864, 8079.272865442138, 8246.216609422216, 8252.298554622925, 8255.091939886608, 8257.545834979133, 5471.699056551928, 5496.5053145217125, 5625.746841392065, 5653.915191272216, 5770.50950669181, 9569.665061722806, 9590.472524010967, 9662.71011869645, 9671.9032809671, 9700.466474343697, 9491.335606507755, 9633.277504187354, 9741.756456088655, 9860.753481163028, 9861.704148875546, 6673.9332606673315, 6827.965860170667, 6995.335443132894, 7355.5586664800285, 7528.924710753042, 7916.168802275678, 8307.916920830714, 8319.334453243848, 8323.583820808813, 8329.50022998622, 7343.559386436831, 7346.742863999734, 7432.293932076444, 7448.1807001228735, 7587.3307872268015, 7000.264972177848, 7024.051753013277, 7034.613096279753, 7166.032585600877, 7265.164506081868, 6893.620850853251, 7045.753398631024, 7057.929420705727, 7059.894101588583, 7063.929360706327, 5012.899742005213, 5072.771725272298, 5107.642465027412, 5145.173463420432, 5328.653637513704, 4835.830745923876, 5004.324416203766, 5044.899102018013, 5110.872228194325, 5143.254228136974], "value": 4479.843760133056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.78967829623923, 355.05201113028204, 356.15235738941317, 360.65737549328145, 361.4379639660329, 5133.897322053556, 5142.197502361213, 5295.761690723917, 5315.76079076442, 5333.280007199027, 5052.974735126329, 5151.974240128803, 5221.503957124077, 5223.347081614798, 5233.502817232356, 4179.477565304337, 4182.0, 4183.351580505011, 4198.895027624303, 4211.431456753345, 3902.512185976753, 3999.4800675912093, 4187.078842654626, 4199.538050814408, 4199.60103790141, 4135.31767258402, 4137.855175068873, 4146.553533415285, 4158.625723684868, 4168.854090106847, 4150.294449943502, 4160.209560183571, 4163.646090082347, 4169.353750168729, 4188.602082802129, 3475.9652403475893, 3721.5906250312446, 3755.830987605564, 3757.7369584129124, 3758.3047136279874, 5065.848024559269, 5074.22402159245, 5089.821856235051, 5100.668456550349, 5100.719460429675, 4641.350210970467, 4676.3453116563705, 4695.577398034194, 4699.2481203007355, 4703.741294228816, 5211.947880521222, 5440.945590544123, 5441.1838224266285, 5458.208559758852, 5477.20580515823, 4014.2939250818285, 4023.476947996771, 4028.3353246714255, 4028.4561584186054, 4038.515378154611, 5635.239242702224, 5638.971805140989, 5653.8586535336535, 5667.910988511271, 5675.631083979528, 4095.9180816383505, 4117.155983023473, 4122.2579935611275, 4123.659810561579, 4130.793460326971, 4034.293998550242, 4104.179164167179, 4145.730527515701, 4161.91676166475, 4182.498100227992, 4695.929561056587, 4705.294205869147, 4713.128071306819, 4735.526447355237, 4761.2382018876815, 5474.91787623186, 5491.697956612345, 5492.505674489315, 5497.175423686399, 5560.4161563036105, 1335.723890631988, 1384.9197625851853, 1392.269058744147, 1397.7769451729737, 1400.0, 943.7263193673895, 964.7925695975399, 969.5055521683992, 974.025974025974, 978.6396908297472, 5125.589952803767, 5133.4096578893905, 5160.8967820643375, 5168.508991645787, 5173.922391164136, 5377.623566350396, 5396.8713933840645, 5417.31622496706, 5422.8915421691345, 5462.617616766788, 5090.236464530276, 5100.38795344561, 5101.617378696613, 5129.9483605860705, 5379.628194810299, 2879.726425989528, 2890.36411989362, 2903.8257704537796, 2906.6076079729387, 2909.810862293944, 5667.943320566824, 5681.755706495994, 5688.971555142198, 5705.942940570624, 5711.514521265739, 5465.376619222716, 5487.890242195133, 5534.833954981276, 5572.60991730575, 5587.972060139755, 5633.802816901389, 5635.380108188096, 5642.802501912495, 5643.7742490299925, 5658.236138121466, 5293.391260005149, 5460.26286451324, 5465.496988328242, 5476.042936814235, 5481.068218402801, 5569.08110161835, 5602.327720673546, 5610.49505544503, 5618.887622247614, 5630.634008789416, 5885.323187833454, 5887.61730487517, 5892.882142357214, 5922.3485416605, 5937.228160339128, 3996.960030399659, 4064.7154699170774, 4122.381642753611, 4168.103857670494, 4176.979115104405, 5598.272224610774, 5621.747021383966, 5625.437456254342, 5626.606137570331, 5635.774569017193, 5502.58730595199, 5511.4213007633625, 5511.476409741068, 5521.309836270466, 5522.475364840334, 5358.33020872391, 5376.445998593328, 5401.594880383908, 5429.40276569585, 5463.972680136574, 5368.355797304349, 5400.351957765093, 5426.186072089218, 5435.619506634498, 5447.536959358499, 5342.519173274424, 5502.367227768857, 5525.9723701382845, 5527.309086364205, 5541.778328866962, 5246.685198888079, 5247.737613119252, 5264.0259902536545, 5265.631405801557, 5272.103742363731], "value": 4195.508310079471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.7796583059248, 745.8993035940147, 807.6365635464043, 844.2528362399275, 867.3798234262501, 13799.172049677014, 14345.211013394246, 14540.345684444199, 14869.776953345681, 15439.614009649764, 13728.519501817438, 13989.370478328474, 14270.500532481365, 14285.92857035716, 14301.642458938531, 721.27872127872, 852.5353682243192, 855.2772906893665, 859.0679113162226, 860.6170254236868, 831.1356189562847, 834.8831163637095, 835.1398059998181, 835.3818174550819, 835.4152093534519, 891.3983061433539, 892.3664198419131, 894.5616647842543, 894.7494701483595, 895.0601868038533, 889.4396530185974, 891.5675897189858, 892.4065496444856, 893.6872094766812, 893.7944272817289, 652.6899722631712, 652.9379708927644, 655.9540832141752, 656.1404560026381, 656.6749459017769, 12858.485660573566, 12881.162724422882, 12899.355032248444, 12941.0, 13795.862041379558, 11533.135014873835, 11636.534538618445, 11642.742428687172, 11701.239419437708, 11721.824172637418, 11240.0, 11316.773664526663, 11433.485493152828, 11448.084153267802, 11481.598144065001, 3807.143392736612, 3835.5780864105204, 3946.2304850554156, 3953.940690889639, 3971.0270983609203, 39212.0, 46204.306935395995, 47192.76403617994, 48068.519314806756, 64744.3525564743, 11364.602238921598, 11726.179167458196, 11871.70320741971, 11885.702857428461, 12090.576829810914, 17298.0, 18004.729929051075, 21132.366029019155, 21136.260230891847, 21141.894290528755, 8837.204651581389, 8907.465552066897, 9154.0, 9341.870160809925, 9393.389429687186, 4862.927056094161, 5032.798688052437, 5080.77136528857, 5115.8721031973755, 5150.072986862401, 3395.7622966392114, 3514.279572687644, 3514.61339252682, 3515.20907795749, 3518.683318501347, 607.0954278125649, 618.3630860213987, 619.6313193649771, 624.9250089989231, 631.5137344244997, 714.7927101140715, 735.4741359927677, 738.2138023005482, 779.2129948751801, 795.5067857928121, 8538.818938112243, 8730.345224108218, 8792.560371981375, 9236.399634023766, 9495.287853411022, 762.2567996203657, 773.1495355109334, 780.4653812138703, 786.3787607789782, 793.9364850811921, 4405.229084910128, 4521.412216411845, 4524.2082635538645, 4526.705764125321, 4528.139653465897, 71673.64163179255, 74216.0, 75031.0, 92504.53747731353, 95084.52457737805, 52190.73904630529, 54146.7292663542, 71679.28320716726, 71808.64095679489, 75522.62238688771, 63518.0, 64256.67871660612, 65144.0, 68120.31879681238, 68608.6569567149, 8983.191512763882, 9250.21373183287, 9418.858717119385, 9454.385464944757, 9546.236301095756, 44263.778681106385, 44493.77753111214, 44869.10261794811, 45378.319325209486, 45714.085718286115, 57205.427945721676, 57806.32905064274, 58471.0, 62615.0, 63220.683896582064, 12579.559715409916, 13187.340632968122, 13270.867291326964, 13347.466101355836, 13556.254406007763, 13499.325033748077, 13740.244286563935, 14335.359695847756, 14600.196989165273, 15081.321340539482, 12685.746285074063, 13094.738105238033, 13320.067595268238, 13346.599602011955, 14015.649608759863, 13460.192388456724, 13802.65493362674, 13817.930910345383, 13992.720145596828, 14321.64195895111, 12379.257244564995, 12823.61529154127, 12959.611211663665, 12975.0, 13165.60503184906, 9865.161461275871, 10527.315724477885, 10566.8414973777, 10598.947005264925, 10610.098141658045, 10612.575496980344, 10624.787504249716, 10686.0, 10849.620263291063, 10878.94560527224], "value": 7115.9206161426255, "unit": "score"}], "name": "dromaeo_css", "value": 7268.149065005249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 112.0, 112.0, 113.0, 114.0, 110.0, 113.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 119.0, 165.0, 121.0, 119.0, 119.0, 120.0, 158.0, 116.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 163.0, 161.0, 160.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 107.0, 87.0, 77.0, 76.0, 77.0, 97.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 83.0, 84.0, 83.0, 108.0, 81.0, 82.0, 118.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 51.0, 49.0, 50.0, 51.0, 50.0, 50.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 59.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 75.0, 81.0, 82.0, 78.0, 75.0, 82.0, 74.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 130.0, 120.0, 121.0, 134.0, 136.0, 128.0, 171.0, 129.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 155.0, 154.0, 151.0, 156.0, 156.0, 155.0, 153.0, 153.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 62.0, 62.0, 63.0, 61.0, 61.0, 63.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1459.8, "alertThreshold": 2.0}]} 21:17:33 INFO - Return code: 0 21:17:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:17:33 INFO - # TBPL SUCCESS # 21:17:33 INFO - Running post-action listener: _resource_record_post_action 21:17:33 INFO - [mozharness: 2016-12-31 05:17:33.163672Z] Finished run-tests step (success) 21:17:33 INFO - Running post-run listener: _resource_record_post_run 21:17:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 262144; Write bytes: 372834304; Read time: 20; Write time: 218516 21:17:33 INFO - TinderboxPrint: CPU usage
13.0% 21:17:33 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 20 21:17:33 INFO - TinderboxPrint: I/O write bytes / time
372,834,304 / 218,516 21:17:33 INFO - TinderboxPrint: CPU idle
8,279.9 (87.0%) 21:17:33 INFO - TinderboxPrint: CPU user
1,190.5 (12.5%) 21:17:33 INFO - TinderboxPrint: Swap in / out
0 / 0 21:17:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124497920; Read time: 0; Write time: 68648 21:17:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247169024; Read time: 20; Write time: 149836 21:17:33 INFO - Running post-run listener: _upload_blobber_files 21:17:33 INFO - Blob upload gear active. 21:17:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:17:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:17:34 INFO - (blobuploader) - INFO - Open directory for files ... 21:17:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:17:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:17:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:34 INFO - (blobuploader) - INFO - Done attempting. 21:17:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:17:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:35 INFO - (blobuploader) - INFO - Done attempting. 21:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:17:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:40 INFO - (blobuploader) - INFO - Done attempting. 21:17:40 INFO - (blobuploader) - INFO - Iteration through files over. 21:17:40 INFO - Return code: 0 21:17:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:17:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:17:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6f3ca4c5c2a75fbb808e508d8f5cb85bdd6d5b6cc7c3d6a9a145a1b6c169414837b9eb66eba8014701cd1a793c845bb3a0bf6093fc9a30694fe3869e0b94de9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdf8b168dc80e191bda578349e7e2f0d5ecb09af94fd4f12ed4fee221b974436ce59b72d577fa22c3571be2c19a637b0b788afdfd9c6d4ac626fcd9f5450f95f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e8190a80a99df45f2f245326de7654fe25e765e9819240eff1303793359d74e5bd12f93a284a504656d899dc410ac830120edbc29ded973e31908967632c592"} 21:17:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:17:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:17:40 INFO - Contents: 21:17:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6f3ca4c5c2a75fbb808e508d8f5cb85bdd6d5b6cc7c3d6a9a145a1b6c169414837b9eb66eba8014701cd1a793c845bb3a0bf6093fc9a30694fe3869e0b94de9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdf8b168dc80e191bda578349e7e2f0d5ecb09af94fd4f12ed4fee221b974436ce59b72d577fa22c3571be2c19a637b0b788afdfd9c6d4ac626fcd9f5450f95f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e8190a80a99df45f2f245326de7654fe25e765e9819240eff1303793359d74e5bd12f93a284a504656d899dc410ac830120edbc29ded973e31908967632c592"} 21:17:40 INFO - Running post-run listener: copy_logs_to_upload_dir 21:17:40 INFO - Copying logs to upload dir... 21:17:40 INFO - mkdir: /builds/slave/test/build/upload/logs 21:17:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.280316 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-30 21:17:39.681698) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 21:17:39.685434) ========= 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=0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346 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/c6f3ca4c5c2a75fbb808e508d8f5cb85bdd6d5b6cc7c3d6a9a145a1b6c169414837b9eb66eba8014701cd1a793c845bb3a0bf6093fc9a30694fe3869e0b94de9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdf8b168dc80e191bda578349e7e2f0d5ecb09af94fd4f12ed4fee221b974436ce59b72d577fa22c3571be2c19a637b0b788afdfd9c6d4ac626fcd9f5450f95f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e8190a80a99df45f2f245326de7654fe25e765e9819240eff1303793359d74e5bd12f93a284a504656d899dc410ac830120edbc29ded973e31908967632c592"} build_url:https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011709 build_url: 'https://queue.taskcluster.net/v1/task/OneRdsCHTYeaO0NTULSH4g/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/c6f3ca4c5c2a75fbb808e508d8f5cb85bdd6d5b6cc7c3d6a9a145a1b6c169414837b9eb66eba8014701cd1a793c845bb3a0bf6093fc9a30694fe3869e0b94de9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cdf8b168dc80e191bda578349e7e2f0d5ecb09af94fd4f12ed4fee221b974436ce59b72d577fa22c3571be2c19a637b0b788afdfd9c6d4ac626fcd9f5450f95f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e8190a80a99df45f2f245326de7654fe25e765e9819240eff1303793359d74e5bd12f93a284a504656d899dc410ac830120edbc29ded973e31908967632c592"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 21:17:39.715962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 21:17:39.716315) ========= 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=0e2a256762fed810e2f0f810000001b3-1483159567.412710-748818346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 21:17:39.799115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 21:17:39.799472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 21:17:39.799786) ========= ========= Total master_lag: 0.18 =========